builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0014 starttime: 1483525805.12 results: success (0) buildid: 20170104004006 builduid: 5cdabe96efff4c4f9bea0dbd25e82dae revision: 236b90305efbbc79f66ca1453be47f3688b26c7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.125780) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.126787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.127231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.154530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.155223) ========= 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.k1iyTwedzz/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.umingERruC/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04 02:30:05-- 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% 48.4M=0s 2017-01-04 02:30:05 (48.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092411 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.276809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.277560) ========= 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.k1iyTwedzz/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.umingERruC/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.026661 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:05.328697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 02:30:05.329511) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 236b90305efbbc79f66ca1453be47f3688b26c7a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 236b90305efbbc79f66ca1453be47f3688b26c7a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k1iyTwedzz/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.umingERruC/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04 02:30:05,426 truncating revision to first 12 chars 2017-01-04 02:30:05,426 Setting DEBUG logging. 2017-01-04 02:30:05,426 attempt 1/10 2017-01-04 02:30:05,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/236b90305efb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 02:30:06,134 unpacking tar archive at: mozilla-aurora-236b90305efb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.987819 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 02:30:06.342822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:06.343191) ========= script_repo_revision: 236b90305efbbc79f66ca1453be47f3688b26c7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:06.343647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:06.343967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 02:30:06.363870) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-01-04 02:30:06.364181) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k1iyTwedzz/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.umingERruC/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:06 INFO - MultiFileLogger online at 20170104 02:30:06 in /builds/slave/test 02:30:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:30:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:06 INFO - {'append_to_log': False, 02:30:06 INFO - 'base_work_dir': '/builds/slave/test', 02:30:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:30:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:06 INFO - 'branch': 'Mozilla-Aurora', 02:30:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:06 INFO - 'config_files': ('talos/mac_config.py',), 02:30:06 INFO - 'default_actions': ('clobber', 02:30:06 INFO - 'read-buildbot-config', 02:30:06 INFO - 'download-and-extract', 02:30:06 INFO - 'populate-webroot', 02:30:06 INFO - 'create-virtualenv', 02:30:06 INFO - 'install', 02:30:06 INFO - 'run-tests'), 02:30:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:06 INFO - 'download_minidump_stackwalk': True, 02:30:06 INFO - 'download_symbols': 'ondemand', 02:30:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:06 INFO - 'installer_path': 'installer.exe', 02:30:06 INFO - 'log_level': 'info', 02:30:06 INFO - 'log_name': 'talos', 02:30:06 INFO - 'log_to_console': True, 02:30:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:30:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:30:06 INFO - 'opt_config_files': (), 02:30:06 INFO - 'pip_index': False, 02:30:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:30:06 INFO - 'cmd': ('bash', 02:30:06 INFO - '-c', 02:30:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:30:06 INFO - 'enabled': True, 02:30:06 INFO - 'halt_on_failure': False, 02:30:06 INFO - 'name': 'check_screen_resolution'},), 02:30:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:30:06 INFO - 'cmd': ('bash', 02:30:06 INFO - '-c', 02:30:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:30:06 INFO - 'enabled': True, 02:30:06 INFO - 'halt_on_failure': False, 02:30:06 INFO - 'name': 'check_screen_resolution'},), 02:30:06 INFO - 'run_cmd_checks_enabled': True, 02:30:06 INFO - 'sps_profile': False, 02:30:06 INFO - 'sps_profile_interval': 0, 02:30:06 INFO - 'suite': 'dromaeojs', 02:30:06 INFO - 'system_bits': '32', 02:30:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:06 INFO - 'title': 't-yosemite-r7-0014', 02:30:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:06 INFO - 'use_talos_json': True, 02:30:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:06 INFO - 'work_dir': 'build'} 02:30:06 INFO - [mozharness: 2017-01-04 10:30:06.570637Z] Running clobber step. 02:30:06 INFO - Running pre-action listener: _resource_record_pre_action 02:30:06 INFO - Running main action method: clobber 02:30:06 INFO - rmtree: /builds/slave/test/build 02:30:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:30:09 INFO - Running post-action listener: _resource_record_post_action 02:30:09 INFO - [mozharness: 2017-01-04 10:30:09.139081Z] Finished clobber step (success) 02:30:09 INFO - [mozharness: 2017-01-04 10:30:09.139229Z] Running read-buildbot-config step. 02:30:09 INFO - Running pre-action listener: _resource_record_pre_action 02:30:09 INFO - Running main action method: read_buildbot_config 02:30:09 INFO - Using buildbot properties: 02:30:09 INFO - { 02:30:09 INFO - "project": "", 02:30:09 INFO - "product": "firefox", 02:30:09 INFO - "script_repo_revision": "production", 02:30:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:30:09 INFO - "repository": "", 02:30:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:30:09 INFO - "buildid": "20170104004006", 02:30:09 INFO - "stage_platform": "macosx64", 02:30:09 INFO - "basedir": "/builds/slave/test", 02:30:09 INFO - "nightly_build": "True", 02:30:09 INFO - "buildnumber": 11, 02:30:09 INFO - "slavename": "t-yosemite-r7-0014", 02:30:09 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:30:09 INFO - "platform": "yosemite_r7", 02:30:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:30:09 INFO - "branch": "mozilla-aurora", 02:30:09 INFO - "repo_path": "releases/mozilla-aurora", 02:30:09 INFO - "revision": "236b90305efbbc79f66ca1453be47f3688b26c7a", 02:30:09 INFO - "pgo_build": "False", 02:30:09 INFO - "builduid": "5cdabe96efff4c4f9bea0dbd25e82dae", 02:30:09 INFO - "slavebuilddir": "test" 02:30:09 INFO - } 02:30:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:30:09 INFO - Running post-action listener: _resource_record_post_action 02:30:09 INFO - [mozharness: 2017-01-04 10:30:09.144582Z] Finished read-buildbot-config step (success) 02:30:09 INFO - [mozharness: 2017-01-04 10:30:09.144709Z] Running download-and-extract step. 02:30:09 INFO - Running pre-action listener: _resource_record_pre_action 02:30:09 INFO - Running main action method: download_and_extract 02:30:09 INFO - mkdir: /builds/slave/test/build/tests 02:30: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')]} 02:30:09 INFO - trying https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:30:09 INFO - Downloading https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:30:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:30:10 INFO - Downloaded 1199 bytes. 02:30:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:30:10 INFO - Using the following test package requirements: 02:30:10 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:30:10 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:30:10 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:30:10 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'jsshell-mac.zip'], 02:30:10 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:30:10 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:30:10 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:30:10 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:30:10 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:30:10 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:30:10 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:30:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:30:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:30:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:30:10 INFO - Fetch https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:30:10 INFO - Http code: 200 02:30:10 INFO - via: 1.1 6e65abb04cb818a6ec78111935b507f7.cloudfront.net (CloudFront) 02:30:10 INFO - x-amz-cf-id: wk9puOR6fUa85kDdxSguR80UFzaotMq4sgijNh_pHftiKKLfRq4mkA== 02:30:10 INFO - x-amz-version-id: BlfzwRj1VpaHbreddTH.Bta5ck6fLugf 02:30:11 INFO - Expected file size: 16269819 02:30:11 INFO - Obtained file size: 16269819 02:30:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:30:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:30:18 INFO - Http code: 200 02:30:18 INFO - via: 1.1 6eaa7f856e226a0db7cef6201d3b8393.cloudfront.net (CloudFront) 02:30:18 INFO - x-amz-cf-id: 48nzAZ4lQuhZ2--MEgqqXGsYgP20BOTlERx4OBkpNRziGB3oCo9EOg== 02:30:18 INFO - x-amz-version-id: BlfzwRj1VpaHbreddTH.Bta5ck6fLugf 02:30:18 INFO - Expected file size: 16269819 02:30:18 INFO - Obtained file size: 16269819 02:30:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:30:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:30:25 INFO - Fetch https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:30:26 INFO - Http code: 200 02:30:26 INFO - via: 1.1 11512f00e812993b9daa35c376d7cb20.cloudfront.net (CloudFront) 02:30:26 INFO - x-amz-cf-id: n2zOqYW7_mjdZD9D1TODR4mYbhOh3O2Z35IV_Lupk06pp_aqdNqmQA== 02:30:26 INFO - x-amz-version-id: 5TPs0XYOZwruVKd3D8VxU2eVVukbqhVx 02:30:26 INFO - Expected file size: 14409038 02:30:26 INFO - Obtained file size: 14409038 02:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:26 INFO - trying https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:30:26 INFO - Downloading https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:30:29 INFO - Downloaded 109943671 bytes. 02:30:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:30:29 INFO - mkdir: /builds/slave/test/properties 02:30:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:30:29 INFO - Writing to file /builds/slave/test/properties/build_url 02:30:29 INFO - Contents: 02:30:29 INFO - build_url:https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:30:30 INFO - Running post-action listener: _resource_record_post_action 02:30:30 INFO - Running post-action listener: set_extra_try_arguments 02:30:30 INFO - [mozharness: 2017-01-04 10:30:30.670411Z] Finished download-and-extract step (success) 02:30:30 INFO - [mozharness: 2017-01-04 10:30:30.670538Z] Running populate-webroot step. 02:30:30 INFO - Running pre-action listener: _resource_record_pre_action 02:30:30 INFO - Running main action method: populate_webroot 02:30:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:30:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:30:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:30:30 INFO - '--tppagecycles', 02:30:30 INFO - '7'], 02:30:30 INFO - 'tests': ['tsvgm']}}, 02:30:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:30:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:30:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:30:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:30:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['damp', 'tps']}, 02:30:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'tests': ['damp', 'tps']}, 02:30:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['dromaeo_dom']}, 02:30:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:30:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['basic_compositor_video']}, 02:30:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:30:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['a11yr', 02:30:30 INFO - 'ts_paint', 02:30:30 INFO - 'tpaint', 02:30:30 INFO - 'sessionrestore', 02:30:30 INFO - 'sessionrestore_no_auto_restore', 02:30:30 INFO - 'tabpaint']}, 02:30:30 INFO - 'other-e10s': {'tests': ['a11yr', 02:30:30 INFO - 'ts_paint', 02:30:30 INFO - 'tpaint', 02:30:30 INFO - 'sessionrestore', 02:30:30 INFO - 'sessionrestore_no_auto_restore', 02:30:30 INFO - 'tabpaint']}, 02:30:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:30:30 INFO - 'ts_paint', 02:30:30 INFO - 'tpaint', 02:30:30 INFO - 'sessionrestore', 02:30:30 INFO - 'sessionrestore_no_auto_restore', 02:30:30 INFO - 'tabpaint']}, 02:30:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:30:30 INFO - 'ts_paint', 02:30:30 INFO - 'tpaint', 02:30:30 INFO - 'sessionrestore', 02:30:30 INFO - 'sessionrestore_no_auto_restore', 02:30:30 INFO - 'tabpaint']}, 02:30:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['a11yr', 02:30:30 INFO - 'ts_paint', 02:30:30 INFO - 'tpaint', 02:30:30 INFO - 'sessionrestore', 02:30:30 INFO - 'sessionrestore_no_auto_restore', 02:30:30 INFO - 'tabpaint']}, 02:30:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['a11yr', 02:30:30 INFO - 'ts_paint', 02:30:30 INFO - 'tpaint', 02:30:30 INFO - 'sessionrestore', 02:30:30 INFO - 'sessionrestore_no_auto_restore', 02:30:30 INFO - 'tabpaint']}, 02:30:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['tsvgx', 02:30:30 INFO - 'tsvgr_opacity', 02:30:30 INFO - 'tart', 02:30:30 INFO - 'tscrollx', 02:30:30 INFO - 'cart']}, 02:30:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:30:30 INFO - 'tsvgr_opacity', 02:30:30 INFO - 'tart', 02:30:30 INFO - 'tscrollx', 02:30:30 INFO - 'cart']}, 02:30:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'talos_options': ['--disable-e10s'], 02:30:30 INFO - 'tests': ['tp5o']}, 02:30:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'tests': ['tp5o']}, 02:30:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'talos_options': ['--disable-e10s', 02:30:30 INFO - '--xperf_path', 02:30:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:30 INFO - 'tests': ['tp5n']}, 02:30:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:30 INFO - 'talos_options': ['--xperf_path', 02:30:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:30 INFO - 'tests': ['tp5n']}}, 02:30:30 INFO - 'talos.zip': {'path': '', 02:30:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:30:30 INFO - Running post-action listener: _resource_record_post_action 02:30:30 INFO - [mozharness: 2017-01-04 10:30:30.689067Z] Finished populate-webroot step (success) 02:30:30 INFO - [mozharness: 2017-01-04 10:30:30.689196Z] Running create-virtualenv step. 02:30:30 INFO - Running pre-action listener: _resource_record_pre_action 02:30:30 INFO - Running main action method: create_virtualenv 02:30:30 INFO - Creating virtualenv /builds/slave/test/build/venv 02:30:30 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 02:30:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:30:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:30:30 INFO - Using real prefix '/tools/python27' 02:30:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:30:31 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:34 INFO - Installing pip.................done. 02:30:34 INFO - Return code: 0 02:30:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:30:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:30:34 INFO - Reading from file tmpfile_stdout 02:30:34 INFO - Output received: 02:30:34 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) 02:30:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:30:34 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')]} 02:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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')]} 02:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:34 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 02:30:34 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 02:30:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:34 INFO - 'HOME': '/Users/cltbld', 02:30:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:34 INFO - 'LOGNAME': 'cltbld', 02:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:34 INFO - 'MOZ_NO_REMOTE': '1', 02:30:34 INFO - 'NO_EM_RESTART': '1', 02:30:34 INFO - 'PAGER': '/bin/cat', 02:30:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:34 INFO - 'PWD': '/builds/slave/test', 02:30:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:34 INFO - 'SHELL': '/bin/bash', 02:30:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:34 INFO - 'USER': 'cltbld', 02:30:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:34 INFO - 'XPC_FLAGS': '0x0', 02:30:34 INFO - 'XPC_SERVICE_NAME': '0', 02:30:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:34 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 02:30:34 INFO - Cleaning up... 02:30:34 INFO - Return code: 0 02:30:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:30:34 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')]} 02:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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')]} 02:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:34 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 02:30:34 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 02:30:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:34 INFO - 'HOME': '/Users/cltbld', 02:30:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:34 INFO - 'LOGNAME': 'cltbld', 02:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:34 INFO - 'MOZ_NO_REMOTE': '1', 02:30:34 INFO - 'NO_EM_RESTART': '1', 02:30:34 INFO - 'PAGER': '/bin/cat', 02:30:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:34 INFO - 'PWD': '/builds/slave/test', 02:30:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:34 INFO - 'SHELL': '/bin/bash', 02:30:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:34 INFO - 'USER': 'cltbld', 02:30:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:34 INFO - 'XPC_FLAGS': '0x0', 02:30:34 INFO - 'XPC_SERVICE_NAME': '0', 02:30:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:35 INFO - Downloading/unpacking psutil>=3.1.1 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:35 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 02:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:38 INFO - Installing collected packages: psutil 02:30:38 INFO - Running setup.py install for psutil 02:30:38 INFO - building 'psutil._psutil_osx' extension 02:30:38 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 02:30:39 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 02:30:39 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 02:30:39 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 02:30:39 INFO - building 'psutil._psutil_posix' extension 02:30:39 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 02:30:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:30:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:30:39 INFO - ^ 02:30:39 INFO - 1 warning generated. 02:30:39 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 02:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:39 INFO - Successfully installed psutil 02:30:39 INFO - Cleaning up... 02:30:40 INFO - Return code: 0 02:30:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:30:40 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')]} 02:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:40 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')]} 02:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:40 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:40 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 02:30:40 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 02:30:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:40 INFO - 'HOME': '/Users/cltbld', 02:30:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:40 INFO - 'LOGNAME': 'cltbld', 02:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:40 INFO - 'MOZ_NO_REMOTE': '1', 02:30:40 INFO - 'NO_EM_RESTART': '1', 02:30:40 INFO - 'PAGER': '/bin/cat', 02:30:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:40 INFO - 'PWD': '/builds/slave/test', 02:30:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:40 INFO - 'SHELL': '/bin/bash', 02:30:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:40 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:40 INFO - 'USER': 'cltbld', 02:30:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:40 INFO - 'XPC_FLAGS': '0x0', 02:30:40 INFO - 'XPC_SERVICE_NAME': '0', 02:30:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:30:42 INFO - Installing collected packages: mozsystemmonitor 02:30:42 INFO - Running setup.py install for mozsystemmonitor 02:30:43 INFO - Successfully installed mozsystemmonitor 02:30:43 INFO - Cleaning up... 02:30:43 INFO - Return code: 0 02:30:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:30:43 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')]} 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:43 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')]} 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:43 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:43 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 02:30:43 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 02:30:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:43 INFO - 'HOME': '/Users/cltbld', 02:30:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:43 INFO - 'LOGNAME': 'cltbld', 02:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:43 INFO - 'MOZ_NO_REMOTE': '1', 02:30:43 INFO - 'NO_EM_RESTART': '1', 02:30:43 INFO - 'PAGER': '/bin/cat', 02:30:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:43 INFO - 'PWD': '/builds/slave/test', 02:30:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:43 INFO - 'SHELL': '/bin/bash', 02:30:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:43 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:43 INFO - 'USER': 'cltbld', 02:30:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:43 INFO - 'XPC_FLAGS': '0x0', 02:30:43 INFO - 'XPC_SERVICE_NAME': '0', 02:30:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:30:43 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 02:30:43 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 02:30:43 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 02:30:43 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 02:30:43 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 02:30:43 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 02:30:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:30:46 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 02:30:46 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 02:30:46 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 02:30:46 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 02:30:46 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 02:30:46 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 02:30:46 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:46 INFO - warning: no files found matching '*.txt' 02:30:46 INFO - no previously-included directories found matching 'build' 02:30:46 INFO - no previously-included directories found matching 'dist' 02:30:46 INFO - no previously-included directories found matching '.git*' 02:30:46 INFO - Installing collected packages: jsonschema, functools32 02:30:46 INFO - Running setup.py install for functools32 02:30:46 INFO - warning: no files found matching '*.txt' 02:30:46 INFO - no previously-included directories found matching 'build' 02:30:46 INFO - no previously-included directories found matching 'dist' 02:30:46 INFO - no previously-included directories found matching '.git*' 02:30:46 INFO - Successfully installed jsonschema functools32 02:30:46 INFO - Cleaning up... 02:30:46 INFO - Return code: 0 02:30:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:30:46 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')]} 02:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:46 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')]} 02:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:46 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:46 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 02:30:46 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 02:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:46 INFO - 'HOME': '/Users/cltbld', 02:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:46 INFO - 'LOGNAME': 'cltbld', 02:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:46 INFO - 'MOZ_NO_REMOTE': '1', 02:30:46 INFO - 'NO_EM_RESTART': '1', 02:30:46 INFO - 'PAGER': '/bin/cat', 02:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:46 INFO - 'PWD': '/builds/slave/test', 02:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:46 INFO - 'SHELL': '/bin/bash', 02:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:46 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:46 INFO - 'USER': 'cltbld', 02:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:46 INFO - 'XPC_FLAGS': '0x0', 02:30:46 INFO - 'XPC_SERVICE_NAME': '0', 02:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:30:47 INFO - Cleaning up... 02:30:47 INFO - Return code: 0 02:30:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:47 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:47 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 02:30:47 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 02:30:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:47 INFO - 'HOME': '/Users/cltbld', 02:30:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:47 INFO - 'LOGNAME': 'cltbld', 02:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:47 INFO - 'MOZ_NO_REMOTE': '1', 02:30:47 INFO - 'NO_EM_RESTART': '1', 02:30:47 INFO - 'PAGER': '/bin/cat', 02:30:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:47 INFO - 'PWD': '/builds/slave/test', 02:30:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:47 INFO - 'SHELL': '/bin/bash', 02:30:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:47 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:47 INFO - 'USER': 'cltbld', 02:30:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:47 INFO - 'XPC_FLAGS': '0x0', 02:30:47 INFO - 'XPC_SERVICE_NAME': '0', 02:30:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:30:47 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 02:30:47 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 02:30:47 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 02:30:47 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 02:30:47 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 02:30:47 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 02:30:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:30:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 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 02:30:50 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 02:30:51 INFO - Downloading docopt-0.6.1.tar.gz 02:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:51 INFO - Running setup.py install for blobuploader 02:30:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:30:51 INFO - Running setup.py install for requests 02:30:52 INFO - Running setup.py install for docopt 02:30:52 INFO - Successfully installed blobuploader requests docopt 02:30:52 INFO - Cleaning up... 02:30:52 INFO - Return code: 0 02:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30: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')]} 02:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:52 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:52 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 02:30:52 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 02:30:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:52 INFO - 'HOME': '/Users/cltbld', 02:30:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:52 INFO - 'LOGNAME': 'cltbld', 02:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:52 INFO - 'MOZ_NO_REMOTE': '1', 02:30:52 INFO - 'NO_EM_RESTART': '1', 02:30:52 INFO - 'PAGER': '/bin/cat', 02:30:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:52 INFO - 'PWD': '/builds/slave/test', 02:30:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:52 INFO - 'SHELL': '/bin/bash', 02:30:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:52 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:52 INFO - 'USER': 'cltbld', 02:30:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:52 INFO - 'XPC_FLAGS': '0x0', 02:30:52 INFO - 'XPC_SERVICE_NAME': '0', 02:30:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-u3ricM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jdof8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-5Jm3TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-wdbfkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:52 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PXEl6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1b_QYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-_384is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-rWIMkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-t79BAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NT7NX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ckgBVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-phi1KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-l1RU2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:53 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-JPqbxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jsmhYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-9GtF7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KItZ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:54 INFO - Running setup.py install for manifestparser 02:30:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:30:54 INFO - Running setup.py install for mozcrash 02:30:54 INFO - Running setup.py install for mozdebug 02:30:54 INFO - Running setup.py install for mozdevice 02:30:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:30:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:30:54 INFO - Running setup.py install for mozfile 02:30:55 INFO - Running setup.py install for mozhttpd 02:30:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Running setup.py install for mozinfo 02:30:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Running setup.py install for mozInstall 02:30:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Running setup.py install for mozleak 02:30:55 INFO - Running setup.py install for mozlog 02:30:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Running setup.py install for moznetwork 02:30:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:30:55 INFO - Running setup.py install for mozprocess 02:30:56 INFO - Running setup.py install for mozprofile 02:30:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:30:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:30:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:30:56 INFO - Running setup.py install for mozrunner 02:30:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:30:56 INFO - Running setup.py install for mozscreenshot 02:30:56 INFO - Running setup.py install for moztest 02:30:56 INFO - Running setup.py install for mozversion 02:30:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:30:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:56 INFO - Cleaning up... 02:30:56 INFO - Return code: 0 02:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:56 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:30:56 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 02:30:56 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 02:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:30:56 INFO - 'HOME': '/Users/cltbld', 02:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:30:56 INFO - 'LOGNAME': 'cltbld', 02:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:56 INFO - 'MOZ_NO_REMOTE': '1', 02:30:56 INFO - 'NO_EM_RESTART': '1', 02:30:56 INFO - 'PAGER': '/bin/cat', 02:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:56 INFO - 'PWD': '/builds/slave/test', 02:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:30:56 INFO - 'SHELL': '/bin/bash', 02:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:30:56 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:30:56 INFO - 'USER': 'cltbld', 02:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:56 INFO - 'XPC_FLAGS': '0x0', 02:30:56 INFO - 'XPC_SERVICE_NAME': '0', 02:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KFyML2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:57 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)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Mtw3H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:57 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)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DYH3dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:57 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)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-pqxaj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-F1qhvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:57 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)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Bv8eiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:57 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)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-4jNCOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:57 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)) 02:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:57 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-aHAvYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-9Ci4gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-h2fHCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-n0qumO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-11UIdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-vHdwCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-VSPMtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0lCkNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Dug1lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:58 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)) 02:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-c9UiLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:59 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)) 02:30:59 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)) 02:30:59 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)) 02:30:59 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)) 02:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 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 02:30:59 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 02:31:01 INFO - Downloading blessings-1.6.tar.gz 02:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:31:01 INFO - Installing collected packages: blessings 02:31:01 INFO - Running setup.py install for blessings 02:31:01 INFO - Successfully installed blessings 02:31:01 INFO - Cleaning up... 02:31:02 INFO - Return code: 0 02:31:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:02 INFO - Reading from file tmpfile_stdout 02:31:02 INFO - Current package versions: 02:31:02 INFO - blessings == 1.6 02:31:02 INFO - blobuploader == 1.2.4 02:31:02 INFO - docopt == 0.6.1 02:31:02 INFO - functools32 == 3.2.3-2 02:31:02 INFO - jsonschema == 2.5.1 02:31:02 INFO - manifestparser == 1.1 02:31:02 INFO - mozInstall == 1.12 02:31:02 INFO - mozcrash == 1.0 02:31:02 INFO - mozdebug == 0.1 02:31:02 INFO - mozdevice == 0.48 02:31:02 INFO - mozfile == 1.2 02:31:02 INFO - mozhttpd == 0.7 02:31:02 INFO - mozinfo == 0.9 02:31:02 INFO - mozleak == 0.1 02:31:02 INFO - mozlog == 3.4 02:31:02 INFO - moznetwork == 0.27 02:31:02 INFO - mozprocess == 0.23 02:31:02 INFO - mozprofile == 0.28 02:31:02 INFO - mozrunner == 6.13 02:31:02 INFO - mozscreenshot == 0.1 02:31:02 INFO - mozsystemmonitor == 0.3 02:31:02 INFO - moztest == 0.8 02:31:02 INFO - mozversion == 1.4 02:31:02 INFO - psutil == 3.1.1 02:31:02 INFO - requests == 1.2.3 02:31:02 INFO - wsgiref == 0.1.2 02:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:03 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 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:31:03 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 02:31:03 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 02:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:03 INFO - 'HOME': '/Users/cltbld', 02:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:03 INFO - 'LOGNAME': 'cltbld', 02:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:03 INFO - 'MOZ_NO_REMOTE': '1', 02:31:03 INFO - 'NO_EM_RESTART': '1', 02:31:03 INFO - 'PAGER': '/bin/cat', 02:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:03 INFO - 'PWD': '/builds/slave/test', 02:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:03 INFO - 'SHELL': '/bin/bash', 02:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:31:03 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:03 INFO - 'USER': 'cltbld', 02:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:03 INFO - 'XPC_FLAGS': '0x0', 02:31:03 INFO - 'XPC_SERVICE_NAME': '0', 02:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 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)) 02:31:03 INFO - Cleaning up... 02:31:03 INFO - Return code: 0 02:31:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d61d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d593570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca4c8ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, '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.k1iyTwedzz/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.umingERruC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 02:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:03 INFO - 'HOME': '/Users/cltbld', 02:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:03 INFO - 'LOGNAME': 'cltbld', 02:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:03 INFO - 'MOZ_NO_REMOTE': '1', 02:31:03 INFO - 'NO_EM_RESTART': '1', 02:31:03 INFO - 'PAGER': '/bin/cat', 02:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:03 INFO - 'PWD': '/builds/slave/test', 02:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:03 INFO - 'SHELL': '/bin/bash', 02:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:31:03 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:03 INFO - 'USER': 'cltbld', 02:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:03 INFO - 'XPC_FLAGS': '0x0', 02:31:03 INFO - 'XPC_SERVICE_NAME': '0', 02:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:31:03 INFO - Cleaning up... 02:31:03 INFO - Return code: 0 02:31:03 INFO - Running post-action listener: _resource_record_post_action 02:31:03 INFO - Running post-action listener: _start_resource_monitoring 02:31:04 INFO - Starting resource monitoring. 02:31:04 INFO - [mozharness: 2017-01-04 10:31:04.021672Z] Finished create-virtualenv step (success) 02:31:04 INFO - [mozharness: 2017-01-04 10:31:04.022639Z] Running install step. 02:31:04 INFO - Running pre-action listener: _resource_record_pre_action 02:31:04 INFO - Running main action method: install 02:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:31:04 INFO - Reading from file tmpfile_stdout 02:31:04 INFO - Detecting whether we're running mozinstall >=1.0... 02:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:31:04 INFO - Reading from file tmpfile_stdout 02:31:04 INFO - Output received: 02:31:04 INFO - Usage: mozinstall [options] installer 02:31:04 INFO - Options: 02:31:04 INFO - -h, --help show this help message and exit 02:31:04 INFO - -d DEST, --destination=DEST 02:31:04 INFO - Directory to install application into. [default: 02:31:04 INFO - "/builds/slave/test"] 02:31:04 INFO - --app=APP Application being installed. [default: firefox] 02:31:04 INFO - mkdir: /builds/slave/test/build/application 02:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:31:35 INFO - Reading from file tmpfile_stdout 02:31:35 INFO - Output received: 02:31:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:31:35 INFO - Running post-action listener: _resource_record_post_action 02:31:35 INFO - [mozharness: 2017-01-04 10:31:35.896424Z] Finished install step (success) 02:31:35 INFO - [mozharness: 2017-01-04 10:31:35.896552Z] Running run-tests step. 02:31:35 INFO - Running pre-action listener: _resource_record_pre_action 02:31:35 INFO - Running main action method: run_tests 02:31:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:31:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:31:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:31:35 INFO - 2017-01-04 02:31:35.911 screenresolution[1631:7353] starting screenresolution argv=screenresolution get 02:31:35 INFO - 2017-01-04 02:31:35.913 screenresolution[1631:7353] Display 0: 1600x1200x32@60 02:31:35 INFO - 2017-01-04 02:31:35.919 screenresolution[1632:7355] starting screenresolution argv=screenresolution list 02:31:35 INFO - Available Modes on Display 0 02:31:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:31:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:31:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:31:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:31:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:31:36 INFO - Intel Iris: 02:31:36 INFO - Chipset Model: Intel Iris 02:31:36 INFO - Type: GPU 02:31:36 INFO - Bus: Built-In 02:31:36 INFO - VRAM (Dynamic, Max): 1536 MB 02:31:36 INFO - Vendor: Intel (0x8086) 02:31:36 INFO - Device ID: 0x0a2e 02:31:36 INFO - Revision ID: 0x0009 02:31:36 INFO - Displays: 02:31:36 INFO - Display: 02:31:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:31:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:31:36 INFO - Display Serial Number: 1600x1200 60 02:31:36 INFO - Main Display: Yes 02:31:36 INFO - Mirror: Off 02:31:36 INFO - Online: Yes 02:31:36 INFO - Rotation: Supported 02:31:36 INFO - Return code: 0 02:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:31:36 INFO - Python 2.7.3 02:31:36 INFO - Return code: 0 02:31:36 INFO - grabbing minidump binary from tooltool 02:31: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')]} 02:31:36 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 0x10d431d30>, '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 0x10d297db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d429b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:31:36 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 02:31:36 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 02:31:36 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 02:31:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:31:36 INFO - Return code: 0 02:31:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:31:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:31:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:31:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:31:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 02:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 02:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k1iyTwedzz/Render', 02:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:31:36 INFO - 'HOME': '/Users/cltbld', 02:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:31:36 INFO - 'LOGNAME': 'cltbld', 02:31:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:31:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:36 INFO - 'MOZ_NO_REMOTE': '1', 02:31:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:31:36 INFO - 'NO_EM_RESTART': '1', 02:31:36 INFO - 'PAGER': '/bin/cat', 02:31:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:36 INFO - 'PWD': '/builds/slave/test', 02:31:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:31:36 INFO - 'SHELL': '/bin/bash', 02:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.umingERruC/Listeners', 02:31:36 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 02:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:31:36 INFO - 'USER': 'cltbld', 02:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:36 INFO - 'XPC_FLAGS': '0x0', 02:31:36 INFO - 'XPC_SERVICE_NAME': '0', 02:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:31:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 02:31:36 INFO - mozversion application_buildid: 20170104004006 02:31:36 INFO - mozversion application_changeset: 236b90305efbbc79f66ca1453be47f3688b26c7a 02:31:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:31:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:31:36 INFO - mozversion application_name: Firefox 02:31:36 INFO - mozversion application_remotingname: firefox-dev 02:31:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:31:36 INFO - mozversion application_vendor: Mozilla 02:31:36 INFO - mozversion application_version: 52.0a2 02:31:36 INFO - mozversion platform_buildid: 20170104004006 02:31:36 INFO - mozversion platform_changeset: 236b90305efbbc79f66ca1453be47f3688b26c7a 02:31:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:31:36 INFO - mozversion platform_version: 52.0a2 02:31:36 INFO - using testdate: 1483525896 02:31:36 INFO - actual date: 1483525896 02:31:36 INFO - starting webserver on 'localhost:49248' 02:31:36 INFO - SUITE-START | Running 2 tests 02:31:36 INFO - TEST-START | dromaeo_css 02:31:36 INFO - operating with platform_type : mac_ 02:31:36 INFO - Initialising browser for dromaeo_css test... 02:31:36 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpo4581T/profile http://localhost:49248/getInfo.html) 02:31:39 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 02:31:39 INFO - PROCESS | 1642 | colorDepth:24 02:31:39 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 02:31:39 INFO - PROCESS | 1642 | __metrics 02:31:39 INFO - PROCESS | 1642 | 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" 02:31:39 INFO - PROCESS | 1642 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:40 INFO - TEST-INFO | 1642: exit 0 02:31:40 INFO - Browser initialized. 02:31:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:40 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpo4581T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:52 INFO - PROCESS | 1645 | RSS: Main: 222167040 02:31:52 INFO - PROCESS | 1645 | 02:34:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 02:35:00 INFO - PROCESS | 1645 | RSS: Main: 305414144 02:35:00 INFO - PROCESS | 1645 | 02:38:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 02:38:04 INFO - PROCESS | 1645 | RSS: Main: 345747456 02:38:04 INFO - PROCESS | 1645 | 02:41:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 02:41:07 INFO - PROCESS | 1645 | RSS: Main: 321052672 02:41:07 INFO - PROCESS | 1645 | 02:44:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 02:44:09 INFO - PROCESS | 1645 | RSS: Main: 322428928 02:44:09 INFO - PROCESS | 1645 | 02:47:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 02:47:14 INFO - PROCESS | 1645 | RSS: Main: 304746496 02:47:14 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 02:50:17 INFO - PROCESS | 1645 | RSS: Main: 358109184 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | __start_tp_report 02:50:17 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 02:50:17 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 02:50:17 INFO - PROCESS | 1645 | |i|pagename|runs| 02:50:17 INFO - PROCESS | 1645 | |0;dojo.html;2598.7791037761785;3268.3299923515683;3277.2462333663248;3279.393312237235;3334.7332213422915;5450.4549545045475;5507.9449205507935;5510.283663123788;5548.223248745174;5571.777128914843;5474.069408200606;5492.286002819638;5497.752601132948;5528.834134975947;5560.749766260518;5043.067032598971;5068.594512439015;5086.79652813887;5164.974175129119;5171.224316352558;5060.569851562622;5079.238114282869;5079.517445842639;5122.641415100945;5150.1759718445055;5164.767585458663;5166.250893620423;5168.405633352175;5175.456577059392;5186.662866913657;5164.870878228075;5165.793368265265;5166.044281807877;5167.974160129213;5169.0954083035695;5021.84934451967;5097.694138351673;5098.745062746885;5099.6685215460875;5110.131277682803;5587.720613969326;5588;5592.7762889484375;5596.160575913605;5600.915986260209;5949.434803693643;5961.225040744675;5963;5976.193213916153;5985.281766188042;6069.969650151721;6070.757169713206;6078.270607527081;6084.178635884144;6106.786262480836;5549.667019978814;5585.636933599344;5604.607677462579;5605.411431799643;5608.214849921014;6127.908081378783;6141.854248382324;6254.593451425642;6260.499160067229;6264.59280146789;5433.673979561239;5765.077587585966;5843.2403787507355;5883.17635531026;5924.555658325643;6084.4828189603495;6107.7862274821055;6119.816405507842;6126.387361263927;6135.202423684892;5841.970790146022;6023.3374328824675;6026.156338112668;6028.849278768066;6030.6080104793045;5915;5926.051831706906;5949.345571987078;5952.375000624958;6008.849778755566;4793.592544633675;4793.952060479351;4800.495947925488;4823.831165909176;4840.854774356775;4260.786960651955;4287.678424118204;4289.163613095417;4294;4326.134773045404;5573.526250268692;5641.774329026793;5644.57665675076;5666.744996475169;5754.079347304411;6026.819195424145;6132.355508992456;6137.34634165833;6147.108669243024;6150.600210986271;5744.138379243063;5775.451332123442;5778.075507918713;5782.595218334676;5787;5017.84946451607;5162.174052151638;5208.1927301269125;5291.444398338196;5291.841244762586;6220.409061139185;6225.346338634378;6229.875402491834;6264.404881536247;6335.176427064452;6133.754649813957;6157.168782214523;6162.22972128484;6170.629762214281;6174.228221472316;6243.906341404973;6287.339829318039;6291.937080629318;6328.0824280478155;6331.556791024768;5734.598578099493;5861.794837180678;5906.586538942404;5934.6735929522565;5984.700764961822;6112.077967281658;6112.807455516588;6129.049997250433;6133.60131591463;6141.692915354125;4728.456227533878;5797.739101740516;5903.114532820111;5909.704514774158;5915.378885217162;5709.429057094258;5785.27684039495;5819.301683797971;5886.264216972879;5914.112883067574;5690.5163061140265;5697.515711164598;5726.398728133652;5737.5983681141915;5808.21589085485;4816.397950256218;5785.218995435731;5893.970530147321;5909.5863289569315;5926.496247818984;5407.702576358338;5626.1842032905815;5687.715614219355;5750.5112065474905;5810.738516766671 02:50:17 INFO - PROCESS | 1645 | |1;ext.html;466.8888046449451;501.38580239207;501.4909866485517;516.5815689291674;535.6812696445613;30441.238969025784;31596.210094747614;39442.8027859861;40830.77507674775;40916.79541602288;42143;42670.35994460078;42722.572774272245;42823;42836.78581607088;9330.486823224719;9501.23990080792;9501.334906556544;9503.524823758818;9536.475493847836;8447.577621118919;8670.219680228778;9374.06259374064;11123.221374503748;11490.482928268206;11369.602063927765;11402.201845870792;11464.770704585902;11515.654530364103;11523.19337646365;11251.0436612888;11254.887451125465;11362;11366.602168924048;11480.598179063734;8456.704015359433;8684.739457816275;8687.218150366498;8755.430896991675;8775.166359195866;39023.804880975695;39587.60412395868;39691;41195.97010074742;41237.38143927843;3266.7713260071805;3316.369889720945;3452.5339079224236;3843.1737176507186;3844.3272427325387;24388.878055609784;24720;26108.60837087445;26242.212733618024;26409.471810563875;2808.8736006879535;3088.83011434371;3116.4857798463227;3157.3843100595395;3207.0859804955476;454630;456353;458323.9999999967;458564;459447;52019.47980520222;53316.73341633267;61373;61461.385386145565;62197.68901155556;62610.373896260455;65306.34693653098;65432.67283663551;65499.672501637186;65582.67208664022;16067.437639682556;16215.594610134605;16229.59426014359;16238.269277882524;16285.185740713154;11354.659360219206;12474.563390281297;12521.56174533887;12531.24812511234;12533;15251.466198682992;16485.505434836974;16685.49943501697;18713.25146994105;19080.427587172406;7330.633468326562;7365.8158546036775;7386.704531818667;7444.925550744531;7453.291937265951;813.1868131868132;890.412327863607;912.6317206848219;968.2399316536485;969.7236287658125;28731.56902646462;29573.85213073964;29667.85166074156;30262.84868575643;30646.69353306483;940.3793496292415;998.1017084623896;1014.2950649298666;1081.2323250492082;1119.0040863631375;13714.588562343146;14584.906132039927;15100.320485578175;15563;15834.60413489672;624187;630183;630479.8476007682;631310;633055;42269.78865105655;42392.788036059625;42434.36348454776;42453.78773106176;42469.93825154396;1207.8429804125408;1256.7549327881159;1344.8453427855532;1368.7399394115087;1380.3650320852319;27048.05331813377;28259;30598.541021884244;31385.215369615944;31611.683883161793;48685.51314486952;49273.52179434479;49288.260676090606;49295.507044929094;49332.50667493279;484902;486622;487060;487529;488426;26047.827847746517;27056.32359190957;27097.051603193795;27119.45761084728;27203.455930880875;38827;45716.77141614271;45984;46004;46165.458635341165;37409.251814963005;38213.56077952997;38858.834234972994;38886;38930.6106938927;32471;35974;39199.2160156801;39420.188787328065;40544.391834121925;37847.81076094602;38191.80904095462;38891.80554097211;38940.80529597334;38968;32317.030489085366;34143.975680729614;34796;34807.651923480444;35164;25708.871455642602;25753.197276190487;25816.612750808377;26071.73928260693;26231.081912132984 02:50:17 INFO - PROCESS | 1645 | |2;jquery.html;343.44705024909905;361.1891304022469;370.3112211287006;372.2573465935459;395.67949960531973;14661.926690366547;14972.32624531896;15716.607084822885;19792.901035494837;20258.797412025877;19201.61596768064;19794.604107917832;20380.898095509503;20622.48443788906;20756;5607.887842243153;5821.67980761058;5935.050391937291;5941.970290148565;5953.077273022688;4459.866204013869;5815.5638327125425;5890.823275301748;5902.409759024084;5907.172995780594;5558.944410555903;5835.241418615574;5843.474087332139;5846.912296315559;5852.063669812831;5694;5791.855203619901;5800.984827655186;5803.158542011427;5807.2450581424355;4947.678400903929;5062.848114556569;5095.898082038376;5106.744662766847;5216.608754343401;12657.746845063139;12713.110082294243;12863.163894346837;12874.356282185854;12877.935610321889;2174.749903761056;2323.314622186459;2428.514297140561;2541.1741184115053;2652.3103992961774;9405;9436.433813971184;9474.95262523683;9914.9504252479;10019.59921603135;1739.747736578189;1764.8146944570763;1808.222464340333;1847.5196448923243;1849.6208277303122;104672;118307;120800.75195488299;122562.38718806439;123484;11003.22977391575;11307.208495405243;11538.019268362283;11584.76830463386;11761.88238117625;14526.564203073925;14540.85459145395;14542.345594448276;14542.41830326775;14578.927105364406;8107.1892810718455;8323.417360784808;8372.246497815226;8492.915070849212;8521.147885211552;8245.320270911978;8263.834723305501;8268.793280168044;8443.915560844436;8469.153084691481;4420.668449866273;4477.8432754854075;4503.864884053483;4516.1419330327135;4621.145088158702;1498.0038274547303;1711.3411336635236;1734.6443978984278;1885.1705249690092;1908.150872861591;693.4556373246977;718.4934621092118;779.6413649721192;841.4951029382322;993.4982833668951;18660.533486662942;19640.803591964184;20997;21064.36806895765;21131.78868211329;910.713125365521;916.3585490156917;933.6312156698066;939.0890835889177;972.6304004478253;8437.071922088566;11096.611618593472;11154.498047587878;11218.382988935688;11220.719482013015;492618;497635;499102;576290;590787;68307.65846170737;70162.29837701557;86226.13773862181;130509;138135.30932345273;969.8108868770663;1005.3917379985149;1005.6882366466418;1005.7083445800782;1006.0945149365483;18782.812171878653;18967.33614323492;19471.805281947;19476.318328858422;19504;51633.70915726986;53329.40011799652;54065;54108.72945635246;56635.43364566466;79400.63296518747;79489.60255198687;80368;81144.59427702824;81264;7873.724419645285;9480.478573678514;11170.888291116984;11302.886971130183;11899.643010709693;12051.578194763491;12450.937745311216;12537.498500059895;12896.742065158456;13134.671633209246;9228.769280768034;10773.515191816543;10908.181886358714;11363.829542557034;11381.43092845338;10755.892441075803;10940.23418360739;11189.272697274651;11244.606438774603;11481.311121332747;5799.623024503394;6985.650717464005;11163.218574699693;11221.460222101878;11317.58530183727;11776.646700598996;11788.23376480526;11864.82202766942;11884.524619015143;12143.635690929286;10997;11117.83323250168;11397.886021139682;11461.713457163638;11467.197296189186 02:50:17 INFO - PROCESS | 1645 | |3;mootools.html;1319.9604011879642;1445.86264304891;1579.8420157984203;1794.3450640516216;1808.6473137738146;6678.732850685973;8298.460600060991;8304.169583041692;8324;8330.416870819045;7335.816604584888;7622.923770762291;7633.893085502599;7856.135825059239;8092.473989190698;2287.0965968442415;2320.6751054852334;2322.7909488146065;2323.9651405228933;2330.067972810872;2315.9652605210936;2342.16853017179;2361.185391040097;2362.007956658199;2362.11420717231;2298.804601608865;2304.274153641606;2331.207389487574;2334.6498025296173;2343.7773411525964;2279.5440911817536;2289.4390874235837;2308.6306191009357;2312.9421764456024;2319.5592837360846;2240.529488807352;2308;2308.4690521180055;2312.09828167015;2312.109837712476;8205.056418511887;8248.54632995185;8251.669933202666;8255.917440825575;8271.875921861178;4320.524742278347;4968.205087186069;5130.897382052375;5133.153029750087;5134.229865520202;3099.2251937015744;3189.1867573768773;3410.0963244740165;3412.982935085309;3415.692587667122;943.4810854030256;944.2163004706146;952.8618350339162;1022.2690776095128;1035.4253389368898;10359.533820978075;10621.41582212978;10625.681229563126;10633.734156646145;10639.57441702331;4347.413099231563;4433.578810013044;4435.090806384684;4474.843380481668;4475.776211189427;8491.363147763943;8603.182697643713;8610.138986101465;8612.48325100496;8635.006974197922;5036.597072234213;5053.0904437200925;5060.367454068241;5062.139436295838;5075.187969924795;3900.278448487039;4083.959160408417;4692.202325604655;4788.592969597623;4796.904061918812;3536.80547569881;3593.7125029997537;3610.711143108545;3643.180284435981;3675.1547144156457;1097.4567589043475;1102.7132945434084;1108.3737688206138;1109.755853712182;1127.3743072594789;759.111839148198;848.8599381102173;871;903.4940433357341;914.3005600715458;5012.473690262543;5484.725763711798;5662.37713851476;5820.243368362086;5955.225820643375;861.5347712235323;962.37926537383;983.6409710455632;1025.1183981775666;1046.3878631000798;3293.86824527021;3623.782573045573;3648.7081033517256;3716;3822.694184465236;9555.331126821195;9849.655262065937;9929.106380425652;9976.80046399068;9980.550875210633;9826.557804898797;9831.115199631924;9844.212463002943;9863.112319891245;9957.55191016406;7303.744368947061;7648.464607477423;7658.770236892902;7712.267334603203;7718.652660630285;5597.720113994365;5624.690642014729;5635.774569017193;5743.540516758733;5743.569232307677;8773.605187766438;8943.016268210362;9215.44707317563;9304.302177336862;9431.245500359817;9161.221296189899;9355.578998944928;9446.197073248852;9450.338476306868;9482.28882833804;7035.859282814417;7149.392301654209;7179.210286868545;7190.568565886064;7249.963750181215;7639.236076392316;7816.882746758917;7824.84350313002;7836.09884863248;7865.921340786519;6970.721171153097;7027.262137475492;7074.893876591958;7075.080239568823;7199.928000719926;6947.965260173667;6971.895421568782;6974.825629359104;7004.754833580801;7014.929850701632;6474.676266186766;6605.438537724347;6678.198616166092;6694.732210711712;6703.765368212089;4797.088553174885;4802.255650374198;4823.638227133049;4860.902781944412;4933.531314525115;4790.257510085942;4812.157872372391;4887.804487820447;4943.901121977612;4998.475160108136 02:50:17 INFO - PROCESS | 1645 | |4;prototype.html;279.05956925162207;297.14422463305675;300.93379456519557;304.41552219738105;311.08385803807795;4287.485501739796;4318.438602981608;4921.064997650444;4963.602911767059;4971.179755340369;3861.517310336208;4956.975215123928;4991.550760431561;5120.590352771778;5123.692578445296;3864.632859878321;3962.7820469874146;3970.2059588082357;3989.3816458448987;4023.5976402359674;3196.744260459158;3540.4689296605457;3608.170120872188;3807.781509916828;4018.4127269728438;3018.3963207358615;3890.396988466778;3951.111000025;3956.327424337855;3982.8207730652043;3528.870761356367;3906.9841841121515;3917.394932369971;3934.69485632069;3977.105151340954;3166.9683303166903;3425.287356321839;3452.792832430037;3466.0295117367177;3468.809215493147;5026.974865125688;5032.823851165228;5047.798088076473;5056.367954005749;5060.46865079165;4289.399484072233;4308.599705095857;4456.9748957739575;4481.887952801173;4486.4616246050355;4758;4781.42622885256;5081.771320290596;5368.30212072432;5398.703071331075;3735.402335626287;3742;3742.8315725792404;3760.736748427611;3761.492198553188;5403.730123420993;5671.347795003545;5680.687562184078;5688.345840228385;5731.856703582402;3777.395616701315;3786.905327366783;3787.7348585599293;3787.8484860605818;3792.715546334036;3645.434957581579;3842.271986889284;3849.2109117630816;3855.6529912307465;3861.2470568238923;3871.3805791073855;4109.794510274474;4177.728447650893;4435.778211089432;4469.7988590513505;4346.6088052075465;5224.9738751306;5350.571954243651;5370.409254981949;5416.566674666017;1215.4166000319897;1229.551213806954;1230.4987914743997;1243.800991841301;1245.5329251530677;698.7903628911408;816.1852711725079;852.5225873510853;856.1866227084295;859.707699382213;4437.489688685842;4865.635077369141;4869.269609558523;5061.468545802712;5098.176367724207;5181.715005674724;5412.807812835807;5549.667019978814;5556.305461817273;5596.692181930033;4987.576056035277;5139.9160503697485;5153.871153221125;5156.432792392834;5196.45437229093;2304.585174668542;2372.110458578033;2579.111395237346;2717.171262764876;2759.9788078411116;4827.758612069382;4948.876278093005;5636.239107720406;5684.651241800027;5731.251968149754;5265.631405801634;5422.237772723881;5473.8357849264585;5483.561315094783;5508.586855985817;4433.00257442073;5644.97177514118;5655.88688226225;5689.800856969986;5693.5160511357;4729.266963620645;5301.240917829798;5305;5319.760610772602;5354.152817278033;4708.905821883474;4924.803007879645;5040.218766091261;5046.880310269622;5245.842624721265;5106.336176297058;5247.845473995715;5656.30526662877;5664.603477756517;5674.744636491285;3047.558104074941;3179.300553878143;3504.421770407854;3675.577308609544;3679.282539904693;4328.696991210585;4642.86071417858;4886.609071274361;5008.722775692175;5106.617003724661;4666.743329116795;4769.141554520081;5301.462575852959;5397.27136836522;5467.043267428264;4653.627709783277;4848.442429120696;5423.267858839006;5423.891522169455;5444.754986025559;4206.348016057394;4212.936805947975;5270.262163297218;5314.574834013347;5320.7386860584875;4002.3796311571755;4891.779869905934;5111.105556527667;5379.193121031876;5402.6758394496455;4388.846390376321;4776.379070720923;4860.642588344721;5250.579953603627;5408.242846001642 02:50:17 INFO - PROCESS | 1645 | |5;yui.html;723.8660847743168;728.927107289271;752.6951584608229;761.4377619311014;777.9727709530164;11609.245399049067;14013.15921044738;14563.635909102277;14816.851831481681;14818.851811481882;10887.891121088807;13201.801972970414;13202.603921882335;13219.6695082623;13246.933765331183;637.4263163153153;655.2333769489709;783.8118851475662;787.6219414680942;806.5523634382915;792.0851416613821;808.3452403553111;808.5754978636234;809.7165991902816;810.6190090657382;860.4020205956863;860.4708104515709;860.5998210831962;860.9741707748777;861.0571424290392;855.3114742632179;855.341387131905;855.4396870050095;855.632078206371;856.400519636254;630.165031333485;630.6972653126479;631.406477910767;631.406477910767;631.5579094633729;13880.86119138816;14337.56987290383;14487.71024579513;14501.27493625325;14513.419463221458;11793.233439826385;11979.10156738248;13337.10704940097;13935.58193254204;13935.651608709763;11795.823062654066;11825.231359961575;11935.16453848231;12026.879731202751;12278.140530162893;4282.635975942048;4333.393324934512;4340.457442819647;4356.455443069616;4456.977715111404;42722;51287;72786;81975.18024819795;83424.58287708584;10290.639827605997;10293.7426564335;10328.328658637165;10399.32404393712;10456.947715261374;19582.90208548948;19628.70556941647;19757.604847902963;19767.90116049439;19797.40607781769;6252.280987686383;6635.6350400728425;7453.105627324756;7597.6201189941385;7741;4083.938176074242;4161.313383291784;4367.366731823868;4454.287314029804;4462.419885414875;2897.116379504271;3374.1733275347697;3388.3223355329033;3429.1941393772445;3471.7222622190166;634.8285962790021;647.184547470191;663.578627571486;668.85619591788;669.1869378704897;505.906407314648;541.196323459662;545.6780499505231;625.8779537990139;689.5586824432368;8116.269535741693;8266.421350505407;8871.64513419456;9018.684346047989;9152.771180720536;503.5506778566861;526.6918852471271;571.3886141828204;648.8280605639509;680.9080774095532;3990.7206495545033;4322.956770432318;4395.296752519582;4421.38100665907;4449.599536041707;70659.2934070663;78813.60593197112;95288;98778.01221987832;100606;57403;66488;72779;86371;88531;67122.66438667971;70009.64995175094;85741.28517429742;88424;88685.11314887027;8982.55087245622;9442.244620430212;9610.903890961281;9614.375065620712;9667.854982175413;47669;47989.280160796916;48938.75530622324;50246.748766255936;51767.741161293954;65309;68999.65500172468;69938;71363.28636713566;73765.6311718438;12469.189502682297;12569.811452828031;12614.51445869525;12857.421416036488;13344.266065366499;13383.842135234763;13772.862271377158;13902.51341203053;14559.563213103624;14643.853561464675;12656.134828774599;12989.740205196033;13011.869881301065;13290.401931912893;13702.45190192381;12333.444994975069;12533.498660053496;13069.673258168621;13186.868131318948;13565.525206617722;11175.944120279346;12318.507259709511;12638.494460221487;12931.418086186331;13028.739425211254;10438.195028909473;10558.894411055791;11040.282381645167;11573;11579.13156513248;11073.224874258725;11301.208915376174;11365.943170284427;11481.712957175803;11551.595694150665 02:50:17 INFO - PROCESS | 1645 | __end_tp_report 02:50:17 INFO - PROCESS | 1645 | __start_cc_report 02:50:17 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2285 02:50:17 INFO - PROCESS | 1645 | __end_cc_report 02:50:17 INFO - PROCESS | 1645 | __startTimestamp1483527017385__endTimestamp 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | ------- Summary: start ------- 02:50:17 INFO - PROCESS | 1645 | Number of tests: 6 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5581.01 Median:5750.51 stddev:641.02 (11.1%) stddev-sans-first:598.77 02:50:17 INFO - PROCESS | 1645 | Values: 2598.8 3268.3 3277.2 3279.4 3334.7 5450.5 5507.9 5510.3 5548.2 5571.8 5474.1 5492.3 5497.8 5528.8 5560.7 5043.1 5068.6 5086.8 5165.0 5171.2 5060.6 5079.2 5079.5 5122.6 5150.2 5164.8 5166.3 5168.4 5175.5 5186.7 5164.9 5165.8 5166.0 5168.0 5169.1 5021.8 5097.7 5098.7 5099.7 5110.1 5587.7 5588.0 5592.8 5596.2 5600.9 5949.4 5961.2 5963.0 5976.2 5985.3 6070.0 6070.8 6078.3 6084.2 6106.8 5549.7 5585.6 5604.6 5605.4 5608.2 6127.9 6141.9 6254.6 6260.5 6264.6 5433.7 5765.1 5843.2 5883.2 5924.6 6084.5 6107.8 6119.8 6126.4 6135.2 5842.0 6023.3 6026.2 6028.8 6030.6 5915.0 5926.1 5949.3 5952.4 6008.8 4793.6 4794.0 4800.5 4823.8 4840.9 4260.8 4287.7 4289.2 4294.0 4326.1 5573.5 5641.8 5644.6 5666.7 5754.1 6026.8 6132.4 6137.3 6147.1 6150.6 5744.1 5775.5 5778.1 5782.6 5787.0 5017.8 5162.2 5208.2 5291.4 5291.8 6220.4 6225.3 6229.9 6264.4 6335.2 6133.8 6157.2 6162.2 6170.6 6174.2 6243.9 6287.3 6291.9 6328.1 6331.6 5734.6 5861.8 5906.6 5934.7 5984.7 6112.1 6112.8 6129.0 6133.6 6141.7 4728.5 5797.7 5903.1 5909.7 5915.4 5709.4 5785.3 5819.3 5886.3 5914.1 5690.5 5697.5 5726.4 5737.6 5808.2 4816.4 5785.2 5894.0 5909.6 5926.5 5407.7 5626.2 5687.7 5750.5 5810.7 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:65797.36 Median:38888.90 stddev:141495.10 (363.8%) stddev-sans-first:141807.01 02:50:17 INFO - PROCESS | 1645 | Values: 466.9 501.4 501.5 516.6 535.7 30441.2 31596.2 39442.8 40830.8 40916.8 42143.0 42670.4 42722.6 42823.0 42836.8 9330.5 9501.2 9501.3 9503.5 9536.5 8447.6 8670.2 9374.1 11123.2 11490.5 11369.6 11402.2 11464.8 11515.7 11523.2 11251.0 11254.9 11362.0 11366.6 11480.6 8456.7 8684.7 8687.2 8755.4 8775.2 39023.8 39587.6 39691.0 41196.0 41237.4 3266.8 3316.4 3452.5 3843.2 3844.3 24388.9 24720.0 26108.6 26242.2 26409.5 2808.9 3088.8 3116.5 3157.4 3207.1 454630.0 456353.0 458324.0 458564.0 459447.0 52019.5 53316.7 61373.0 61461.4 62197.7 62610.4 65306.3 65432.7 65499.7 65582.7 16067.4 16215.6 16229.6 16238.3 16285.2 11354.7 12474.6 12521.6 12531.2 12533.0 15251.5 16485.5 16685.5 18713.3 19080.4 7330.6 7365.8 7386.7 7444.9 7453.3 813.2 890.4 912.6 968.2 969.7 28731.6 29573.9 29667.9 30262.8 30646.7 940.4 998.1 1014.3 1081.2 1119.0 13714.6 14584.9 15100.3 15563.0 15834.6 624187.0 630183.0 630479.8 631310.0 633055.0 42269.8 42392.8 42434.4 42453.8 42469.9 1207.8 1256.8 1344.8 1368.7 1380.4 27048.1 28259.0 30598.5 31385.2 31611.7 48685.5 49273.5 49288.3 49295.5 49332.5 484902.0 486622.0 487060.0 487529.0 488426.0 26047.8 27056.3 27097.1 27119.5 27203.5 38827.0 45716.8 45984.0 46004.0 46165.5 37409.3 38213.6 38858.8 38886.0 38930.6 32471.0 35974.0 39199.2 39420.2 40544.4 37847.8 38191.8 38891.8 38940.8 38968.0 32317.0 34144.0 34796.0 34807.7 35164.0 25708.9 25753.2 25816.6 26071.7 26231.1 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:32047.69 Median:11653.27 stddev:89145.37 (765.0%) stddev-sans-first:89363.66 02:50:17 INFO - PROCESS | 1645 | Values: 343.4 361.2 370.3 372.3 395.7 14661.9 14972.3 15716.6 19792.9 20258.8 19201.6 19794.6 20380.9 20622.5 20756.0 5607.9 5821.7 5935.1 5942.0 5953.1 4459.9 5815.6 5890.8 5902.4 5907.2 5558.9 5835.2 5843.5 5846.9 5852.1 5694.0 5791.9 5801.0 5803.2 5807.2 4947.7 5062.8 5095.9 5106.7 5216.6 12657.7 12713.1 12863.2 12874.4 12877.9 2174.7 2323.3 2428.5 2541.2 2652.3 9405.0 9436.4 9475.0 9915.0 10019.6 1739.7 1764.8 1808.2 1847.5 1849.6 104672.0 118307.0 120800.8 122562.4 123484.0 11003.2 11307.2 11538.0 11584.8 11761.9 14526.6 14540.9 14542.3 14542.4 14578.9 8107.2 8323.4 8372.2 8492.9 8521.1 8245.3 8263.8 8268.8 8443.9 8469.2 4420.7 4477.8 4503.9 4516.1 4621.1 1498.0 1711.3 1734.6 1885.2 1908.2 693.5 718.5 779.6 841.5 993.5 18660.5 19640.8 20997.0 21064.4 21131.8 910.7 916.4 933.6 939.1 972.6 8437.1 11096.6 11154.5 11218.4 11220.7 492618.0 497635.0 499102.0 576290.0 590787.0 68307.7 70162.3 86226.1 130509.0 138135.3 969.8 1005.4 1005.7 1005.7 1006.1 18782.8 18967.3 19471.8 19476.3 19504.0 51633.7 53329.4 54065.0 54108.7 56635.4 79400.6 79489.6 80368.0 81144.6 81264.0 7873.7 9480.5 11170.9 11302.9 11899.6 12051.6 12450.9 12537.5 12896.7 13134.7 9228.8 10773.5 10908.2 11363.8 11381.4 10755.9 10940.2 11189.3 11244.6 11481.3 5799.6 6985.7 11163.2 11221.5 11317.6 11776.6 11788.2 11864.8 11884.5 12143.6 10997.0 11117.8 11397.9 11461.7 11467.2 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5336.08 Median:5541.22 stddev:2904.21 (52.4%) stddev-sans-first:2896.67 02:50:17 INFO - PROCESS | 1645 | Values: 1320.0 1445.9 1579.8 1794.3 1808.6 6678.7 8298.5 8304.2 8324.0 8330.4 7335.8 7622.9 7633.9 7856.1 8092.5 2287.1 2320.7 2322.8 2324.0 2330.1 2316.0 2342.2 2361.2 2362.0 2362.1 2298.8 2304.3 2331.2 2334.6 2343.8 2279.5 2289.4 2308.6 2312.9 2319.6 2240.5 2308.0 2308.5 2312.1 2312.1 8205.1 8248.5 8251.7 8255.9 8271.9 4320.5 4968.2 5130.9 5133.2 5134.2 3099.2 3189.2 3410.1 3413.0 3415.7 943.5 944.2 952.9 1022.3 1035.4 10359.5 10621.4 10625.7 10633.7 10639.6 4347.4 4433.6 4435.1 4474.8 4475.8 8491.4 8603.2 8610.1 8612.5 8635.0 5036.6 5053.1 5060.4 5062.1 5075.2 3900.3 4084.0 4692.2 4788.6 4796.9 3536.8 3593.7 3610.7 3643.2 3675.2 1097.5 1102.7 1108.4 1109.8 1127.4 759.1 848.9 871.0 903.5 914.3 5012.5 5484.7 5662.4 5820.2 5955.2 861.5 962.4 983.6 1025.1 1046.4 3293.9 3623.8 3648.7 3716.0 3822.7 9555.3 9849.7 9929.1 9976.8 9980.6 9826.6 9831.1 9844.2 9863.1 9957.6 7303.7 7648.5 7658.8 7712.3 7718.7 5597.7 5624.7 5635.8 5743.5 5743.6 8773.6 8943.0 9215.4 9304.3 9431.2 9161.2 9355.6 9446.2 9450.3 9482.3 7035.9 7149.4 7179.2 7190.6 7250.0 7639.2 7816.9 7824.8 7836.1 7865.9 6970.7 7027.3 7074.9 7075.1 7199.9 6948.0 6971.9 6974.8 7004.8 7014.9 6474.7 6605.4 6678.2 6694.7 6703.8 4797.1 4802.3 4823.6 4860.9 4933.5 4790.3 4812.2 4887.8 4943.9 4998.5 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4290.40 Median:4838.10 stddev:1319.08 (27.3%) stddev-sans-first:1287.96 02:50:17 INFO - PROCESS | 1645 | Values: 279.1 297.1 300.9 304.4 311.1 4287.5 4318.4 4921.1 4963.6 4971.2 3861.5 4957.0 4991.6 5120.6 5123.7 3864.6 3962.8 3970.2 3989.4 4023.6 3196.7 3540.5 3608.2 3807.8 4018.4 3018.4 3890.4 3951.1 3956.3 3982.8 3528.9 3907.0 3917.4 3934.7 3977.1 3167.0 3425.3 3452.8 3466.0 3468.8 5027.0 5032.8 5047.8 5056.4 5060.5 4289.4 4308.6 4457.0 4481.9 4486.5 4758.0 4781.4 5081.8 5368.3 5398.7 3735.4 3742.0 3742.8 3760.7 3761.5 5403.7 5671.3 5680.7 5688.3 5731.9 3777.4 3786.9 3787.7 3787.8 3792.7 3645.4 3842.3 3849.2 3855.7 3861.2 3871.4 4109.8 4177.7 4435.8 4469.8 4346.6 5225.0 5350.6 5370.4 5416.6 1215.4 1229.6 1230.5 1243.8 1245.5 698.8 816.2 852.5 856.2 859.7 4437.5 4865.6 4869.3 5061.5 5098.2 5181.7 5412.8 5549.7 5556.3 5596.7 4987.6 5139.9 5153.9 5156.4 5196.5 2304.6 2372.1 2579.1 2717.2 2760.0 4827.8 4948.9 5636.2 5684.7 5731.3 5265.6 5422.2 5473.8 5483.6 5508.6 4433.0 5645.0 5655.9 5689.8 5693.5 4729.3 5301.2 5305.0 5319.8 5354.2 4708.9 4924.8 5040.2 5046.9 5245.8 5106.3 5247.8 5656.3 5664.6 5674.7 3047.6 3179.3 3504.4 3675.6 3679.3 4328.7 4642.9 4886.6 5008.7 5106.6 4666.7 4769.1 5301.5 5397.3 5467.0 4653.6 4848.4 5423.3 5423.9 5444.8 4206.3 4212.9 5270.3 5314.6 5320.7 4002.4 4891.8 5111.1 5379.2 5402.7 4388.8 4776.4 4860.6 5250.6 5408.2 02:50:17 INFO - PROCESS | 1645 | 02:50:17 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:18350.06 Median:4459.70 stddev:25259.81 (566.4%) stddev-sans-first:25296.00 02:50:17 INFO - PROCESS | 1645 | Values: 723.9 728.9 752.7 761.4 778.0 11609.2 14013.2 14563.6 14816.9 14818.9 10887.9 13201.8 13202.6 13219.7 13246.9 637.4 655.2 783.8 787.6 806.6 792.1 808.3 808.6 809.7 810.6 860.4 860.5 860.6 861.0 861.1 855.3 855.3 855.4 855.6 856.4 630.2 630.7 631.4 631.4 631.6 13880.9 14337.6 14487.7 14501.3 14513.4 11793.2 11979.1 13337.1 13935.6 13935.7 11795.8 11825.2 11935.2 12026.9 12278.1 4282.6 4333.4 4340.5 4356.5 4457.0 42722.0 51287.0 72786.0 81975.2 83424.6 10290.6 10293.7 10328.3 10399.3 10456.9 19582.9 19628.7 19757.6 19767.9 19797.4 6252.3 6635.6 7453.1 7597.6 7741.0 4083.9 4161.3 4367.4 4454.3 4462.4 2897.1 3374.2 3388.3 3429.2 3471.7 634.8 647.2 663.6 668.9 669.2 505.9 541.2 545.7 625.9 689.6 8116.3 8266.4 8871.6 9018.7 9152.8 503.6 526.7 571.4 648.8 680.9 3990.7 4323.0 4395.3 4421.4 4449.6 70659.3 78813.6 95288.0 98778.0 100606.0 57403.0 66488.0 72779.0 86371.0 88531.0 67122.7 70009.6 85741.3 88424.0 88685.1 8982.6 9442.2 9610.9 9614.4 9667.9 47669.0 47989.3 48938.8 50246.7 51767.7 65309.0 68999.7 69938.0 71363.3 73765.6 12469.2 12569.8 12614.5 12857.4 13344.3 13383.8 13772.9 13902.5 14559.6 14643.9 12656.1 12989.7 13011.9 13290.4 13702.5 12333.4 12533.5 13069.7 13186.9 13565.5 11175.9 12318.5 12638.5 12931.4 13028.7 10438.2 10558.9 11040.3 11573.0 11579.1 11073.2 11301.2 11365.9 11481.7 11551.6 02:50:17 INFO - PROCESS | 1645 | -------- Summary: end -------- 02:50:17 INFO - PROCESS | 1645 | 02:50:18 INFO - TEST-INFO | 1645: exit 0 02:50:18 INFO - TEST-OK | dromaeo_css | took 1121532ms 02:50:18 INFO - TEST-START | kraken 02:50:18 INFO - operating with platform_type : mac_ 02:50:18 INFO - Initialising browser for kraken test... 02:50:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmppeg7RV/profile http://localhost:49248/getInfo.html) 02:50:20 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 02:50:20 INFO - PROCESS | 1655 | colorDepth:24 02:50:20 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 02:50:20 INFO - PROCESS | 1655 | __metrics 02:50:20 INFO - PROCESS | 1655 | 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" 02:50:20 INFO - PROCESS | 1655 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:50:21 INFO - TEST-INFO | 1655: exit 0 02:50:21 INFO - Browser initialized. 02:50:21 INFO - Running cycle 1/1 for kraken test... 02:50:21 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmppeg7RV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:33 INFO - PROCESS | 1657 | RSS: Main: 222605312 02:50:33 INFO - PROCESS | 1657 | 02:50:36 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 02:50:37 INFO - PROCESS | 1657 | RSS: Main: 272617472 02:50:37 INFO - PROCESS | 1657 | 02:50:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 02:50:40 INFO - PROCESS | 1657 | RSS: Main: 283295744 02:50:40 INFO - PROCESS | 1657 | 02:50:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 02:50:44 INFO - PROCESS | 1657 | RSS: Main: 380628992 02:50:44 INFO - PROCESS | 1657 | 02:50:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 02:50:47 INFO - PROCESS | 1657 | RSS: Main: 281845760 02:50:47 INFO - PROCESS | 1657 | 02:50:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:50:49 INFO - PROCESS | 1657 | RSS: Main: 283783168 02:50:49 INFO - PROCESS | 1657 | 02:50:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 02:50:53 INFO - PROCESS | 1657 | RSS: Main: 324571136 02:50:53 INFO - PROCESS | 1657 | 02:50:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:56 INFO - PROCESS | 1657 | RSS: Main: 325128192 02:50:56 INFO - PROCESS | 1657 | 02:50:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 02:51:00 INFO - PROCESS | 1657 | RSS: Main: 324853760 02:51:00 INFO - PROCESS | 1657 | 02:51:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:51:02 INFO - PROCESS | 1657 | RSS: Main: 299360256 02:51:02 INFO - PROCESS | 1657 | 02:51:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:05 INFO - PROCESS | 1657 | RSS: Main: 303210496 02:51:05 INFO - PROCESS | 1657 | 02:51:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:51:07 INFO - PROCESS | 1657 | RSS: Main: 304660480 02:51:07 INFO - PROCESS | 1657 | 02:51:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:51:11 INFO - PROCESS | 1657 | RSS: Main: 316284928 02:51:11 INFO - PROCESS | 1657 | 02:51:14 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:51:15 INFO - PROCESS | 1657 | RSS: Main: 315953152 02:51:15 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 02:51:17 INFO - PROCESS | 1657 | RSS: Main: 359751680 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | __start_tp_report 02:51:17 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 02:51:17 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 02:51:17 INFO - PROCESS | 1657 | |i|pagename|runs| 02:51:17 INFO - PROCESS | 1657 | |0;ai-astar;116;115;112;115;115;116;114;114;115;122 02:51:17 INFO - PROCESS | 1657 | |1;audio-beat-detection;146;111;113;158;141;111;111;139;170;111 02:51:17 INFO - PROCESS | 1657 | |2;audio-dft;195;259;210;185;183;183;184;186;186;182 02:51:17 INFO - PROCESS | 1657 | |3;audio-fft;81;49;77;113;83;65;60;58;82;58 02:51:17 INFO - PROCESS | 1657 | |4;audio-oscillator;90;70;94;70;67;69;89;68;69;93 02:51:17 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;90;86;89;86;88;86;89;86;89;86 02:51:17 INFO - PROCESS | 1657 | |6;imaging-darkroom;96;94;95;95;99;142;113;96;96;102 02:51:17 INFO - PROCESS | 1657 | |7;imaging-desaturate;82;82;81;79;83;82;85;87;84;83 02:51:17 INFO - PROCESS | 1657 | |8;json-parse-financial;57;56;56;57;59;58;59;57;58;58 02:51:17 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;65;66;73;77;99;99;96;98;68;69 02:51:17 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;80;99;79;83;84;84;83;84;84;84 02:51:17 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;142;168;157;148;143;133;147;138;209;172 02:51:17 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;167;161;219;205;164;165;165;165;221;195 02:51:17 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;68;71;66;84;67;66;68;66;67;68 02:51:17 INFO - PROCESS | 1657 | __end_tp_report 02:51:17 INFO - PROCESS | 1657 | __start_cc_report 02:51:17 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2042 02:51:17 INFO - PROCESS | 1657 | __end_cc_report 02:51:17 INFO - PROCESS | 1657 | __startTimestamp1483527077359__endTimestamp 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | ------- Summary: start ------- 02:51:17 INFO - PROCESS | 1657 | Number of tests: 14 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:2.59 (2.3%) stddev-sans-first:2.74 02:51:17 INFO - PROCESS | 1657 | Values: 116.0 115.0 112.0 115.0 115.0 116.0 114.0 114.0 115.0 122.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:140.00 stddev:22.52 (16.1%) stddev-sans-first:23.23 02:51:17 INFO - PROCESS | 1657 | Values: 146.0 111.0 113.0 158.0 141.0 111.0 111.0 139.0 170.0 111.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:195.30 Median:186.00 stddev:23.94 (12.9%) stddev-sans-first:25.40 02:51:17 INFO - PROCESS | 1657 | Values: 195.0 259.0 210.0 185.0 183.0 183.0 184.0 186.0 186.0 182.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:72.60 Median:71.00 stddev:18.61 (26.2%) stddev-sans-first:19.49 02:51:17 INFO - PROCESS | 1657 | Values: 81.0 49.0 77.0 113.0 83.0 65.0 60.0 58.0 82.0 58.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:11.82 (14.9%) stddev-sans-first:11.70 02:51:17 INFO - PROCESS | 1657 | Values: 90.0 70.0 94.0 70.0 67.0 69.0 89.0 68.0 69.0 93.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.65 (1.9%) stddev-sans-first:1.48 02:51:17 INFO - PROCESS | 1657 | Values: 90.0 86.0 89.0 86.0 88.0 86.0 89.0 86.0 89.0 86.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:95.50 stddev:14.88 (15.6%) stddev-sans-first:15.58 02:51:17 INFO - PROCESS | 1657 | Values: 96.0 94.0 95.0 95.0 99.0 142.0 113.0 96.0 96.0 102.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:82.80 Median:83.00 stddev:2.20 (2.7%) stddev-sans-first:2.32 02:51:17 INFO - PROCESS | 1657 | Values: 82.0 82.0 81.0 79.0 83.0 82.0 85.0 87.0 84.0 83.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:1.08 (1.9%) stddev-sans-first:1.13 02:51:17 INFO - PROCESS | 1657 | Values: 57.0 56.0 56.0 57.0 59.0 58.0 59.0 57.0 58.0 58.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:86.50 stddev:15.04 (17.4%) stddev-sans-first:14.80 02:51:17 INFO - PROCESS | 1657 | Values: 65.0 66.0 73.0 77.0 99.0 99.0 96.0 98.0 68.0 69.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:5.44 (6.5%) stddev-sans-first:5.53 02:51:17 INFO - PROCESS | 1657 | Values: 80.0 99.0 79.0 83.0 84.0 84.0 83.0 84.0 84.0 84.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:152.50 stddev:22.54 (14.8%) stddev-sans-first:23.35 02:51:17 INFO - PROCESS | 1657 | Values: 142.0 168.0 157.0 148.0 143.0 133.0 147.0 138.0 209.0 172.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:181.00 stddev:24.59 (13.6%) stddev-sans-first:25.41 02:51:17 INFO - PROCESS | 1657 | Values: 167.0 161.0 219.0 205.0 164.0 165.0 165.0 165.0 221.0 195.0 02:51:17 INFO - PROCESS | 1657 | 02:51:17 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.00 stddev:5.45 (8.0%) stddev-sans-first:5.76 02:51:17 INFO - PROCESS | 1657 | Values: 68.0 71.0 66.0 84.0 67.0 66.0 68.0 66.0 67.0 68.0 02:51:17 INFO - PROCESS | 1657 | -------- Summary: end -------- 02:51:17 INFO - PROCESS | 1657 | 02:51:18 INFO - TEST-INFO | 1657: exit 0 02:51:18 INFO - TEST-OK | kraken | took 60430ms 02:51:18 INFO - SUITE-END | took 1181s 02:51:18 INFO - Completed test suite (00:19:42) 02:51:18 INFO - javascript benchmark 02:51:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.7791037761785, 3268.3299923515683, 3277.2462333663248, 3279.393312237235, 3334.7332213422915, 5450.4549545045475, 5507.9449205507935, 5510.283663123788, 5548.223248745174, 5571.777128914843, 5474.069408200606, 5492.286002819638, 5497.752601132948, 5528.834134975947, 5560.749766260518, 5043.067032598971, 5068.594512439015, 5086.79652813887, 5164.974175129119, 5171.224316352558, 5060.569851562622, 5079.238114282869, 5079.517445842639, 5122.641415100945, 5150.1759718445055, 5164.767585458663, 5166.250893620423, 5168.405633352175, 5175.456577059392, 5186.662866913657, 5164.870878228075, 5165.793368265265, 5166.044281807877, 5167.974160129213, 5169.0954083035695, 5021.84934451967, 5097.694138351673, 5098.745062746885, 5099.6685215460875, 5110.131277682803, 5587.720613969326, 5588.0, 5592.7762889484375, 5596.160575913605, 5600.915986260209, 5949.434803693643, 5961.225040744675, 5963.0, 5976.193213916153, 5985.281766188042, 6069.969650151721, 6070.757169713206, 6078.270607527081, 6084.178635884144, 6106.786262480836, 5549.667019978814, 5585.636933599344, 5604.607677462579, 5605.411431799643, 5608.214849921014, 6127.908081378783, 6141.854248382324, 6254.593451425642, 6260.499160067229, 6264.59280146789, 5433.673979561239, 5765.077587585966, 5843.2403787507355, 5883.17635531026, 5924.555658325643, 6084.4828189603495, 6107.7862274821055, 6119.816405507842, 6126.387361263927, 6135.202423684892, 5841.970790146022, 6023.3374328824675, 6026.156338112668, 6028.849278768066, 6030.6080104793045, 5915.0, 5926.051831706906, 5949.345571987078, 5952.375000624958, 6008.849778755566, 4793.592544633675, 4793.952060479351, 4800.495947925488, 4823.831165909176, 4840.854774356775, 4260.786960651955, 4287.678424118204, 4289.163613095417, 4294.0, 4326.134773045404, 5573.526250268692, 5641.774329026793, 5644.57665675076, 5666.744996475169, 5754.079347304411, 6026.819195424145, 6132.355508992456, 6137.34634165833, 6147.108669243024, 6150.600210986271, 5744.138379243063, 5775.451332123442, 5778.075507918713, 5782.595218334676, 5787.0, 5017.84946451607, 5162.174052151638, 5208.1927301269125, 5291.444398338196, 5291.841244762586, 6220.409061139185, 6225.346338634378, 6229.875402491834, 6264.404881536247, 6335.176427064452, 6133.754649813957, 6157.168782214523, 6162.22972128484, 6170.629762214281, 6174.228221472316, 6243.906341404973, 6287.339829318039, 6291.937080629318, 6328.0824280478155, 6331.556791024768, 5734.598578099493, 5861.794837180678, 5906.586538942404, 5934.6735929522565, 5984.700764961822, 6112.077967281658, 6112.807455516588, 6129.049997250433, 6133.60131591463, 6141.692915354125, 4728.456227533878, 5797.739101740516, 5903.114532820111, 5909.704514774158, 5915.378885217162, 5709.429057094258, 5785.27684039495, 5819.301683797971, 5886.264216972879, 5914.112883067574, 5690.5163061140265, 5697.515711164598, 5726.398728133652, 5737.5983681141915, 5808.21589085485, 4816.397950256218, 5785.218995435731, 5893.970530147321, 5909.5863289569315, 5926.496247818984, 5407.702576358338, 5626.1842032905815, 5687.715614219355, 5750.5112065474905, 5810.738516766671], "value": 5538.5461978148915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.8888046449451, 501.38580239207, 501.4909866485517, 516.5815689291674, 535.6812696445613, 30441.238969025784, 31596.210094747614, 39442.8027859861, 40830.77507674775, 40916.79541602288, 42143.0, 42670.35994460078, 42722.572774272245, 42823.0, 42836.78581607088, 9330.486823224719, 9501.23990080792, 9501.334906556544, 9503.524823758818, 9536.475493847836, 8447.577621118919, 8670.219680228778, 9374.06259374064, 11123.221374503748, 11490.482928268206, 11369.602063927765, 11402.201845870792, 11464.770704585902, 11515.654530364103, 11523.19337646365, 11251.0436612888, 11254.887451125465, 11362.0, 11366.602168924048, 11480.598179063734, 8456.704015359433, 8684.739457816275, 8687.218150366498, 8755.430896991675, 8775.166359195866, 39023.804880975695, 39587.60412395868, 39691.0, 41195.97010074742, 41237.38143927843, 3266.7713260071805, 3316.369889720945, 3452.5339079224236, 3843.1737176507186, 3844.3272427325387, 24388.878055609784, 24720.0, 26108.60837087445, 26242.212733618024, 26409.471810563875, 2808.8736006879535, 3088.83011434371, 3116.4857798463227, 3157.3843100595395, 3207.0859804955476, 454630.0, 456353.0, 458323.9999999967, 458564.0, 459447.0, 52019.47980520222, 53316.73341633267, 61373.0, 61461.385386145565, 62197.68901155556, 62610.373896260455, 65306.34693653098, 65432.67283663551, 65499.672501637186, 65582.67208664022, 16067.437639682556, 16215.594610134605, 16229.59426014359, 16238.269277882524, 16285.185740713154, 11354.659360219206, 12474.563390281297, 12521.56174533887, 12531.24812511234, 12533.0, 15251.466198682992, 16485.505434836974, 16685.49943501697, 18713.25146994105, 19080.427587172406, 7330.633468326562, 7365.8158546036775, 7386.704531818667, 7444.925550744531, 7453.291937265951, 813.1868131868132, 890.412327863607, 912.6317206848219, 968.2399316536485, 969.7236287658125, 28731.56902646462, 29573.85213073964, 29667.85166074156, 30262.84868575643, 30646.69353306483, 940.3793496292415, 998.1017084623896, 1014.2950649298666, 1081.2323250492082, 1119.0040863631375, 13714.588562343146, 14584.906132039927, 15100.320485578175, 15563.0, 15834.60413489672, 624187.0, 630183.0, 630479.8476007682, 631310.0, 633055.0, 42269.78865105655, 42392.788036059625, 42434.36348454776, 42453.78773106176, 42469.93825154396, 1207.8429804125408, 1256.7549327881159, 1344.8453427855532, 1368.7399394115087, 1380.3650320852319, 27048.05331813377, 28259.0, 30598.541021884244, 31385.215369615944, 31611.683883161793, 48685.51314486952, 49273.52179434479, 49288.260676090606, 49295.507044929094, 49332.50667493279, 484902.0, 486622.0, 487060.0, 487529.0, 488426.0, 26047.827847746517, 27056.32359190957, 27097.051603193795, 27119.45761084728, 27203.455930880875, 38827.0, 45716.77141614271, 45984.0, 46004.0, 46165.458635341165, 37409.251814963005, 38213.56077952997, 38858.834234972994, 38886.0, 38930.6106938927, 32471.0, 35974.0, 39199.2160156801, 39420.188787328065, 40544.391834121925, 37847.81076094602, 38191.80904095462, 38891.80554097211, 38940.80529597334, 38968.0, 32317.030489085366, 34143.975680729614, 34796.0, 34807.651923480444, 35164.0, 25708.871455642602, 25753.197276190487, 25816.612750808377, 26071.73928260693, 26231.081912132984], "value": 19449.390897212666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.44705024909905, 361.1891304022469, 370.3112211287006, 372.2573465935459, 395.67949960531973, 14661.926690366547, 14972.32624531896, 15716.607084822885, 19792.901035494837, 20258.797412025877, 19201.61596768064, 19794.604107917832, 20380.898095509503, 20622.48443788906, 20756.0, 5607.887842243153, 5821.67980761058, 5935.050391937291, 5941.970290148565, 5953.077273022688, 4459.866204013869, 5815.5638327125425, 5890.823275301748, 5902.409759024084, 5907.172995780594, 5558.944410555903, 5835.241418615574, 5843.474087332139, 5846.912296315559, 5852.063669812831, 5694.0, 5791.855203619901, 5800.984827655186, 5803.158542011427, 5807.2450581424355, 4947.678400903929, 5062.848114556569, 5095.898082038376, 5106.744662766847, 5216.608754343401, 12657.746845063139, 12713.110082294243, 12863.163894346837, 12874.356282185854, 12877.935610321889, 2174.749903761056, 2323.314622186459, 2428.514297140561, 2541.1741184115053, 2652.3103992961774, 9405.0, 9436.433813971184, 9474.95262523683, 9914.9504252479, 10019.59921603135, 1739.747736578189, 1764.8146944570763, 1808.222464340333, 1847.5196448923243, 1849.6208277303122, 104672.0, 118307.0, 120800.75195488299, 122562.38718806439, 123484.0, 11003.22977391575, 11307.208495405243, 11538.019268362283, 11584.76830463386, 11761.88238117625, 14526.564203073925, 14540.85459145395, 14542.345594448276, 14542.41830326775, 14578.927105364406, 8107.1892810718455, 8323.417360784808, 8372.246497815226, 8492.915070849212, 8521.147885211552, 8245.320270911978, 8263.834723305501, 8268.793280168044, 8443.915560844436, 8469.153084691481, 4420.668449866273, 4477.8432754854075, 4503.864884053483, 4516.1419330327135, 4621.145088158702, 1498.0038274547303, 1711.3411336635236, 1734.6443978984278, 1885.1705249690092, 1908.150872861591, 693.4556373246977, 718.4934621092118, 779.6413649721192, 841.4951029382322, 993.4982833668951, 18660.533486662942, 19640.803591964184, 20997.0, 21064.36806895765, 21131.78868211329, 910.713125365521, 916.3585490156917, 933.6312156698066, 939.0890835889177, 972.6304004478253, 8437.071922088566, 11096.611618593472, 11154.498047587878, 11218.382988935688, 11220.719482013015, 492618.0, 497635.0, 499102.0, 576290.0, 590787.0, 68307.65846170737, 70162.29837701557, 86226.13773862181, 130509.0, 138135.30932345273, 969.8108868770663, 1005.3917379985149, 1005.6882366466418, 1005.7083445800782, 1006.0945149365483, 18782.812171878653, 18967.33614323492, 19471.805281947, 19476.318328858422, 19504.0, 51633.70915726986, 53329.40011799652, 54065.0, 54108.72945635246, 56635.43364566466, 79400.63296518747, 79489.60255198687, 80368.0, 81144.59427702824, 81264.0, 7873.724419645285, 9480.478573678514, 11170.888291116984, 11302.886971130183, 11899.643010709693, 12051.578194763491, 12450.937745311216, 12537.498500059895, 12896.742065158456, 13134.671633209246, 9228.769280768034, 10773.515191816543, 10908.181886358714, 11363.829542557034, 11381.43092845338, 10755.892441075803, 10940.23418360739, 11189.272697274651, 11244.606438774603, 11481.311121332747, 5799.623024503394, 6985.650717464005, 11163.218574699693, 11221.460222101878, 11317.58530183727, 11776.646700598996, 11788.23376480526, 11864.82202766942, 11884.524619015143, 12143.635690929286, 10997.0, 11117.83323250168, 11397.886021139682, 11461.713457163638, 11467.197296189186], "value": 9234.961737300107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.9604011879642, 1445.86264304891, 1579.8420157984203, 1794.3450640516216, 1808.6473137738146, 6678.732850685973, 8298.460600060991, 8304.169583041692, 8324.0, 8330.416870819045, 7335.816604584888, 7622.923770762291, 7633.893085502599, 7856.135825059239, 8092.473989190698, 2287.0965968442415, 2320.6751054852334, 2322.7909488146065, 2323.9651405228933, 2330.067972810872, 2315.9652605210936, 2342.16853017179, 2361.185391040097, 2362.007956658199, 2362.11420717231, 2298.804601608865, 2304.274153641606, 2331.207389487574, 2334.6498025296173, 2343.7773411525964, 2279.5440911817536, 2289.4390874235837, 2308.6306191009357, 2312.9421764456024, 2319.5592837360846, 2240.529488807352, 2308.0, 2308.4690521180055, 2312.09828167015, 2312.109837712476, 8205.056418511887, 8248.54632995185, 8251.669933202666, 8255.917440825575, 8271.875921861178, 4320.524742278347, 4968.205087186069, 5130.897382052375, 5133.153029750087, 5134.229865520202, 3099.2251937015744, 3189.1867573768773, 3410.0963244740165, 3412.982935085309, 3415.692587667122, 943.4810854030256, 944.2163004706146, 952.8618350339162, 1022.2690776095128, 1035.4253389368898, 10359.533820978075, 10621.41582212978, 10625.681229563126, 10633.734156646145, 10639.57441702331, 4347.413099231563, 4433.578810013044, 4435.090806384684, 4474.843380481668, 4475.776211189427, 8491.363147763943, 8603.182697643713, 8610.138986101465, 8612.48325100496, 8635.006974197922, 5036.597072234213, 5053.0904437200925, 5060.367454068241, 5062.139436295838, 5075.187969924795, 3900.278448487039, 4083.959160408417, 4692.202325604655, 4788.592969597623, 4796.904061918812, 3536.80547569881, 3593.7125029997537, 3610.711143108545, 3643.180284435981, 3675.1547144156457, 1097.4567589043475, 1102.7132945434084, 1108.3737688206138, 1109.755853712182, 1127.3743072594789, 759.111839148198, 848.8599381102173, 871.0, 903.4940433357341, 914.3005600715458, 5012.473690262543, 5484.725763711798, 5662.37713851476, 5820.243368362086, 5955.225820643375, 861.5347712235323, 962.37926537383, 983.6409710455632, 1025.1183981775666, 1046.3878631000798, 3293.86824527021, 3623.782573045573, 3648.7081033517256, 3716.0, 3822.694184465236, 9555.331126821195, 9849.655262065937, 9929.106380425652, 9976.80046399068, 9980.550875210633, 9826.557804898797, 9831.115199631924, 9844.212463002943, 9863.112319891245, 9957.55191016406, 7303.744368947061, 7648.464607477423, 7658.770236892902, 7712.267334603203, 7718.652660630285, 5597.720113994365, 5624.690642014729, 5635.774569017193, 5743.540516758733, 5743.569232307677, 8773.605187766438, 8943.016268210362, 9215.44707317563, 9304.302177336862, 9431.245500359817, 9161.221296189899, 9355.578998944928, 9446.197073248852, 9450.338476306868, 9482.28882833804, 7035.859282814417, 7149.392301654209, 7179.210286868545, 7190.568565886064, 7249.963750181215, 7639.236076392316, 7816.882746758917, 7824.84350313002, 7836.09884863248, 7865.921340786519, 6970.721171153097, 7027.262137475492, 7074.893876591958, 7075.080239568823, 7199.928000719926, 6947.965260173667, 6971.895421568782, 6974.825629359104, 7004.754833580801, 7014.929850701632, 6474.676266186766, 6605.438537724347, 6678.198616166092, 6694.732210711712, 6703.765368212089, 4797.088553174885, 4802.255650374198, 4823.638227133049, 4860.902781944412, 4933.531314525115, 4790.257510085942, 4812.157872372391, 4887.804487820447, 4943.901121977612, 4998.475160108136], "value": 4331.295532141193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.05956925162207, 297.14422463305675, 300.93379456519557, 304.41552219738105, 311.08385803807795, 4287.485501739796, 4318.438602981608, 4921.064997650444, 4963.602911767059, 4971.179755340369, 3861.517310336208, 4956.975215123928, 4991.550760431561, 5120.590352771778, 5123.692578445296, 3864.632859878321, 3962.7820469874146, 3970.2059588082357, 3989.3816458448987, 4023.5976402359674, 3196.744260459158, 3540.4689296605457, 3608.170120872188, 3807.781509916828, 4018.4127269728438, 3018.3963207358615, 3890.396988466778, 3951.111000025, 3956.327424337855, 3982.8207730652043, 3528.870761356367, 3906.9841841121515, 3917.394932369971, 3934.69485632069, 3977.105151340954, 3166.9683303166903, 3425.287356321839, 3452.792832430037, 3466.0295117367177, 3468.809215493147, 5026.974865125688, 5032.823851165228, 5047.798088076473, 5056.367954005749, 5060.46865079165, 4289.399484072233, 4308.599705095857, 4456.9748957739575, 4481.887952801173, 4486.4616246050355, 4758.0, 4781.42622885256, 5081.771320290596, 5368.30212072432, 5398.703071331075, 3735.402335626287, 3742.0, 3742.8315725792404, 3760.736748427611, 3761.492198553188, 5403.730123420993, 5671.347795003545, 5680.687562184078, 5688.345840228385, 5731.856703582402, 3777.395616701315, 3786.905327366783, 3787.7348585599293, 3787.8484860605818, 3792.715546334036, 3645.434957581579, 3842.271986889284, 3849.2109117630816, 3855.6529912307465, 3861.2470568238923, 3871.3805791073855, 4109.794510274474, 4177.728447650893, 4435.778211089432, 4469.7988590513505, 4346.6088052075465, 5224.9738751306, 5350.571954243651, 5370.409254981949, 5416.566674666017, 1215.4166000319897, 1229.551213806954, 1230.4987914743997, 1243.800991841301, 1245.5329251530677, 698.7903628911408, 816.1852711725079, 852.5225873510853, 856.1866227084295, 859.707699382213, 4437.489688685842, 4865.635077369141, 4869.269609558523, 5061.468545802712, 5098.176367724207, 5181.715005674724, 5412.807812835807, 5549.667019978814, 5556.305461817273, 5596.692181930033, 4987.576056035277, 5139.9160503697485, 5153.871153221125, 5156.432792392834, 5196.45437229093, 2304.585174668542, 2372.110458578033, 2579.111395237346, 2717.171262764876, 2759.9788078411116, 4827.758612069382, 4948.876278093005, 5636.239107720406, 5684.651241800027, 5731.251968149754, 5265.631405801634, 5422.237772723881, 5473.8357849264585, 5483.561315094783, 5508.586855985817, 4433.00257442073, 5644.97177514118, 5655.88688226225, 5689.800856969986, 5693.5160511357, 4729.266963620645, 5301.240917829798, 5305.0, 5319.760610772602, 5354.152817278033, 4708.905821883474, 4924.803007879645, 5040.218766091261, 5046.880310269622, 5245.842624721265, 5106.336176297058, 5247.845473995715, 5656.30526662877, 5664.603477756517, 5674.744636491285, 3047.558104074941, 3179.300553878143, 3504.421770407854, 3675.577308609544, 3679.282539904693, 4328.696991210585, 4642.86071417858, 4886.609071274361, 5008.722775692175, 5106.617003724661, 4666.743329116795, 4769.141554520081, 5301.462575852959, 5397.27136836522, 5467.043267428264, 4653.627709783277, 4848.442429120696, 5423.267858839006, 5423.891522169455, 5444.754986025559, 4206.348016057394, 4212.936805947975, 5270.262163297218, 5314.574834013347, 5320.7386860584875, 4002.3796311571755, 4891.779869905934, 5111.105556527667, 5379.193121031876, 5402.6758394496455, 4388.846390376321, 4776.379070720923, 4860.642588344721, 5250.579953603627, 5408.242846001642], "value": 3870.366950242633, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8660847743168, 728.927107289271, 752.6951584608229, 761.4377619311014, 777.9727709530164, 11609.245399049067, 14013.15921044738, 14563.635909102277, 14816.851831481681, 14818.851811481882, 10887.891121088807, 13201.801972970414, 13202.603921882335, 13219.6695082623, 13246.933765331183, 637.4263163153153, 655.2333769489709, 783.8118851475662, 787.6219414680942, 806.5523634382915, 792.0851416613821, 808.3452403553111, 808.5754978636234, 809.7165991902816, 810.6190090657382, 860.4020205956863, 860.4708104515709, 860.5998210831962, 860.9741707748777, 861.0571424290392, 855.3114742632179, 855.341387131905, 855.4396870050095, 855.632078206371, 856.400519636254, 630.165031333485, 630.6972653126479, 631.406477910767, 631.406477910767, 631.5579094633729, 13880.86119138816, 14337.56987290383, 14487.71024579513, 14501.27493625325, 14513.419463221458, 11793.233439826385, 11979.10156738248, 13337.10704940097, 13935.58193254204, 13935.651608709763, 11795.823062654066, 11825.231359961575, 11935.16453848231, 12026.879731202751, 12278.140530162893, 4282.635975942048, 4333.393324934512, 4340.457442819647, 4356.455443069616, 4456.977715111404, 42722.0, 51287.0, 72786.0, 81975.18024819795, 83424.58287708584, 10290.639827605997, 10293.7426564335, 10328.328658637165, 10399.32404393712, 10456.947715261374, 19582.90208548948, 19628.70556941647, 19757.604847902963, 19767.90116049439, 19797.40607781769, 6252.280987686383, 6635.6350400728425, 7453.105627324756, 7597.6201189941385, 7741.0, 4083.938176074242, 4161.313383291784, 4367.366731823868, 4454.287314029804, 4462.419885414875, 2897.116379504271, 3374.1733275347697, 3388.3223355329033, 3429.1941393772445, 3471.7222622190166, 634.8285962790021, 647.184547470191, 663.578627571486, 668.85619591788, 669.1869378704897, 505.906407314648, 541.196323459662, 545.6780499505231, 625.8779537990139, 689.5586824432368, 8116.269535741693, 8266.421350505407, 8871.64513419456, 9018.684346047989, 9152.771180720536, 503.5506778566861, 526.6918852471271, 571.3886141828204, 648.8280605639509, 680.9080774095532, 3990.7206495545033, 4322.956770432318, 4395.296752519582, 4421.38100665907, 4449.599536041707, 70659.2934070663, 78813.60593197112, 95288.0, 98778.01221987832, 100606.0, 57403.0, 66488.0, 72779.0, 86371.0, 88531.0, 67122.66438667971, 70009.64995175094, 85741.28517429742, 88424.0, 88685.11314887027, 8982.55087245622, 9442.244620430212, 9610.903890961281, 9614.375065620712, 9667.854982175413, 47669.0, 47989.280160796916, 48938.75530622324, 50246.748766255936, 51767.741161293954, 65309.0, 68999.65500172468, 69938.0, 71363.28636713566, 73765.6311718438, 12469.189502682297, 12569.811452828031, 12614.51445869525, 12857.421416036488, 13344.266065366499, 13383.842135234763, 13772.862271377158, 13902.51341203053, 14559.563213103624, 14643.853561464675, 12656.134828774599, 12989.740205196033, 13011.869881301065, 13290.401931912893, 13702.45190192381, 12333.444994975069, 12533.498660053496, 13069.673258168621, 13186.868131318948, 13565.525206617722, 11175.944120279346, 12318.507259709511, 12638.494460221487, 12931.418086186331, 13028.739425211254, 10438.195028909473, 10558.894411055791, 11040.282381645167, 11573.0, 11579.13156513248, 11073.224874258725, 11301.208915376174, 11365.943170284427, 11481.712957175803, 11551.595694150665], "value": 7048.917934409185, "unit": "score"}], "name": "dromaeo_css", "value": 6999.168924869594, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 112.0, 115.0, 115.0, 116.0, 114.0, 114.0, 115.0, 122.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 113.0, 158.0, 141.0, 111.0, 111.0, 139.0, 170.0, 111.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 259.0, 210.0, 185.0, 183.0, 183.0, 184.0, 186.0, 186.0, 182.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 49.0, 77.0, 113.0, 83.0, 65.0, 60.0, 58.0, 82.0, 58.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 94.0, 70.0, 67.0, 69.0, 89.0, 68.0, 69.0, 93.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 86.0, 88.0, 86.0, 89.0, 86.0, 89.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 99.0, 142.0, 113.0, 96.0, 96.0, 102.0], "value": 102.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 79.0, 83.0, 82.0, 85.0, 87.0, 84.0, 83.0], "value": 82.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 59.0, 58.0, 59.0, 57.0, 58.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 73.0, 77.0, 99.0, 99.0, 96.0, 98.0, 68.0, 69.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 99.0, 79.0, 83.0, 84.0, 84.0, 83.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 168.0, 157.0, 148.0, 143.0, 133.0, 147.0, 138.0, 209.0, 172.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 219.0, 205.0, 164.0, 165.0, 165.0, 165.0, 221.0, 195.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 66.0, 84.0, 67.0, 66.0, 68.0, 66.0, 67.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1495.8, "alertThreshold": 2.0}]} 02:51:18 INFO - Return code: 0 02:51:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:51:18 INFO - # TBPL SUCCESS # 02:51:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:51:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:51:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:51:18 INFO - 2017-01-04 02:51:18.690 screenresolution[1661:9780] starting screenresolution argv=screenresolution get 02:51:18 INFO - 2017-01-04 02:51:18.694 screenresolution[1661:9780] Display 0: 1600x1200x32@60 02:51:18 INFO - 2017-01-04 02:51:18.700 screenresolution[1662:9783] starting screenresolution argv=screenresolution list 02:51:18 INFO - Available Modes on Display 0 02:51:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:51:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:51:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:51:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:51:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:51:18 INFO - Intel Iris: 02:51:18 INFO - Chipset Model: Intel Iris 02:51:18 INFO - Type: GPU 02:51:18 INFO - Bus: Built-In 02:51:18 INFO - VRAM (Dynamic, Max): 1536 MB 02:51:18 INFO - Vendor: Intel (0x8086) 02:51:18 INFO - Device ID: 0x0a2e 02:51:18 INFO - Revision ID: 0x0009 02:51:18 INFO - Displays: 02:51:18 INFO - Display: 02:51:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:51:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:51:18 INFO - Display Serial Number: 1600x1200 60 02:51:18 INFO - Main Display: Yes 02:51:18 INFO - Mirror: Off 02:51:18 INFO - Online: Yes 02:51:18 INFO - Rotation: Supported 02:51:18 INFO - Return code: 0 02:51:18 INFO - Running post-action listener: _resource_record_post_action 02:51:18 INFO - [mozharness: 2017-01-04 10:51:18.948707Z] Finished run-tests step (success) 02:51:18 INFO - Running post-run listener: _resource_record_post_run 02:51:19 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 39445504; Write bytes: 657909248; Read time: 390; Write time: 2281 02:51:19 INFO - TinderboxPrint: CPU usage
53.4% 02:51:19 INFO - TinderboxPrint: I/O read bytes / time
39,445,504 / 390 02:51:19 INFO - TinderboxPrint: I/O write bytes / time
657,909,248 / 2,281 02:51:19 INFO - TinderboxPrint: CPU idle
2,261.8 (46.6%) 02:51:19 INFO - TinderboxPrint: CPU system
971.5 (20.0%) 02:51:19 INFO - TinderboxPrint: CPU user
1,624.3 (33.4%) 02:51:19 INFO - TinderboxPrint: Swap in / out
387,993,600 / 0 02:51:19 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 336667136; Write bytes: 333723648; Read time: 26530; Write time: 682 02:51:19 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 38446080; Write bytes: 306490880; Read time: 375; Write time: 1531 02:51:19 INFO - Running post-run listener: _upload_blobber_files 02:51:19 INFO - Blob upload gear active. 02:51:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:51:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:51:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:51:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:20 INFO - (blobuploader) - INFO - Done attempting. 02:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:22 INFO - (blobuploader) - INFO - Done attempting. 02:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:24 INFO - (blobuploader) - INFO - Done attempting. 02:51:24 INFO - (blobuploader) - INFO - Iteration through files over. 02:51:24 INFO - Return code: 0 02:51:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:51:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:51:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d2265c218114c7ea7433acc394ed82119f7ddea0ab38eca8cc5f8f3af1f3e1950049cda7453dec573cc4a0388db14d7ff214702a4d44140cef3a76589a81d7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68d69a269ff4af51aa28f56bdd21c74f1f4c0e90ffa4e31ffee844120ea401d57800e4c27b9b90726e04a3f5de3666cb018af3971e6c079b7cbcce9e0c14c043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d304001e73c4e499ee6f27871cf36af9466cd29f3b4be81ec120be8dbbfd1478e85cbc81108ca4e4a8342e221ee255d051b054556832d2c1e96257fbc376e0d9"} 02:51:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:51:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:51:24 INFO - Contents: 02:51:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d2265c218114c7ea7433acc394ed82119f7ddea0ab38eca8cc5f8f3af1f3e1950049cda7453dec573cc4a0388db14d7ff214702a4d44140cef3a76589a81d7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68d69a269ff4af51aa28f56bdd21c74f1f4c0e90ffa4e31ffee844120ea401d57800e4c27b9b90726e04a3f5de3666cb018af3971e6c079b7cbcce9e0c14c043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d304001e73c4e499ee6f27871cf36af9466cd29f3b4be81ec120be8dbbfd1478e85cbc81108ca4e4a8342e221ee255d051b054556832d2c1e96257fbc376e0d9"} 02:51:24 INFO - Running post-run listener: copy_logs_to_upload_dir 02:51:24 INFO - Copying logs to upload dir... 02:51:24 INFO - mkdir: /builds/slave/test/build/upload/logs 02:51:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.919531 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-01-04 02:51:24.340372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-01-04 02:51:24.344857) ========= 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.k1iyTwedzz/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.umingERruC/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d2265c218114c7ea7433acc394ed82119f7ddea0ab38eca8cc5f8f3af1f3e1950049cda7453dec573cc4a0388db14d7ff214702a4d44140cef3a76589a81d7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68d69a269ff4af51aa28f56bdd21c74f1f4c0e90ffa4e31ffee844120ea401d57800e4c27b9b90726e04a3f5de3666cb018af3971e6c079b7cbcce9e0c14c043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d304001e73c4e499ee6f27871cf36af9466cd29f3b4be81ec120be8dbbfd1478e85cbc81108ca4e4a8342e221ee255d051b054556832d2c1e96257fbc376e0d9"} build_url:https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/X4H5Ox8xRF-zzlAgYjEYrg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d2265c218114c7ea7433acc394ed82119f7ddea0ab38eca8cc5f8f3af1f3e1950049cda7453dec573cc4a0388db14d7ff214702a4d44140cef3a76589a81d7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68d69a269ff4af51aa28f56bdd21c74f1f4c0e90ffa4e31ffee844120ea401d57800e4c27b9b90726e04a3f5de3666cb018af3971e6c079b7cbcce9e0c14c043", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d304001e73c4e499ee6f27871cf36af9466cd29f3b4be81ec120be8dbbfd1478e85cbc81108ca4e4a8342e221ee255d051b054556832d2c1e96257fbc376e0d9"}' ========= master_lag: 3.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-01-04 02:51:27.624583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:51:27.624953) ========= 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.k1iyTwedzz/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.umingERruC/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005073 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:51:27.653460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 02:51:27.653802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 02:51:27.654080) ========= ========= Total master_lag: 3.43 =========