builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0004 starttime: 1491411663.91 results: success (0) buildid: 20170405081820 builduid: 243e6977b7e141909c00ea35e5476a7c revision: 720b9177c6856c1c4339d0fac1bf5149c0d53950 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:03.910405) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:03.910954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:03.911351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:03.938600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:03.938960) ========= 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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-05 10:01:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-04-05 10:01:04 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136471 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:04.128457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:04.128840) ========= 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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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.028150 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:04.179712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 10:01:04.180158) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720b9177c6856c1c4339d0fac1bf5149c0d53950 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 720b9177c6856c1c4339d0fac1bf5149c0d53950 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gDMERQ5I1c/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.1g76O5Ifnj/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-05 10:01:04,291 truncating revision to first 12 chars 2017-04-05 10:01:04,291 Setting DEBUG logging. 2017-04-05 10:01:04,291 attempt 1/10 2017-04-05 10:01:04,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720b9177c685?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 10:01:07,026 unpacking tar archive at: mozilla-central-720b9177c685/testing/mozharness/ program finished with exit code 0 elapsedTime=3.015611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 10:01:07.220363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:07.220829) ========= script_repo_revision: 720b9177c6856c1c4339d0fac1bf5149c0d53950 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:07.221355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:07.221719) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 10:01:07.243404) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-04-05 10:01:07.243882) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gDMERQ5I1c/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.1g76O5Ifnj/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:01:07 INFO - MultiFileLogger online at 20170405 10:01:07 in /builds/slave/test 10:01:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:01:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:07 INFO - {'append_to_log': False, 10:01:07 INFO - 'base_work_dir': '/builds/slave/test', 10:01:07 INFO - 'blob_upload_branch': 'Firefox', 10:01:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:07 INFO - 'branch': 'Firefox', 10:01:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:07 INFO - 'config_files': ('talos/mac_config.py',), 10:01:07 INFO - 'default_actions': ('clobber', 10:01:07 INFO - 'read-buildbot-config', 10:01:07 INFO - 'download-and-extract', 10:01:07 INFO - 'populate-webroot', 10:01:07 INFO - 'create-virtualenv', 10:01:07 INFO - 'install', 10:01:07 INFO - 'run-tests'), 10:01:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:07 INFO - 'download_minidump_stackwalk': True, 10:01:07 INFO - 'download_symbols': 'ondemand', 10:01:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:07 INFO - 'gecko_profile': False, 10:01:07 INFO - 'gecko_profile_interval': 0, 10:01:07 INFO - 'installer_path': 'installer.exe', 10:01:07 INFO - 'log_level': 'info', 10:01:07 INFO - 'log_name': 'talos', 10:01:07 INFO - 'log_to_console': True, 10:01:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:01:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:01:07 INFO - 'opt_config_files': (), 10:01:07 INFO - 'pip_index': False, 10:01:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:01:07 INFO - 'cmd': ('bash', 10:01:07 INFO - '-c', 10:01:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:01:07 INFO - 'enabled': True, 10:01:07 INFO - 'halt_on_failure': False, 10:01:07 INFO - 'name': 'check_screen_resolution'},), 10:01:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:01:07 INFO - 'cmd': ('bash', 10:01:07 INFO - '-c', 10:01:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:01:07 INFO - 'enabled': True, 10:01:07 INFO - 'halt_on_failure': False, 10:01:07 INFO - 'name': 'check_screen_resolution'},), 10:01:07 INFO - 'run_cmd_checks_enabled': True, 10:01:07 INFO - 'suite': 'dromaeojs', 10:01:07 INFO - 'system_bits': '32', 10:01:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:07 INFO - 'title': 't-yosemite-r7-0004', 10:01:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:07 INFO - 'use_talos_json': True, 10:01:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:07 INFO - 'work_dir': 'build'} 10:01:07 INFO - [mozharness: 2017-04-05 17:01:07.461693Z] Running clobber step. 10:01:07 INFO - Running pre-action listener: _resource_record_pre_action 10:01:07 INFO - Running main action method: clobber 10:01:07 INFO - rmtree: /builds/slave/test/build 10:01:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:11 INFO - Running post-action listener: _resource_record_post_action 10:01:11 INFO - [mozharness: 2017-04-05 17:01:11.924062Z] Finished clobber step (success) 10:01:11 INFO - [mozharness: 2017-04-05 17:01:11.924261Z] Running read-buildbot-config step. 10:01:11 INFO - Running pre-action listener: _resource_record_pre_action 10:01:11 INFO - Running main action method: read_buildbot_config 10:01:11 INFO - Using buildbot properties: 10:01:11 INFO - { 10:01:11 INFO - "project": "", 10:01:11 INFO - "product": "firefox", 10:01:11 INFO - "script_repo_revision": "production", 10:01:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:01:11 INFO - "repository": "", 10:01:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:01:11 INFO - "buildid": "20170405081820", 10:01:11 INFO - "pgo_build": "False", 10:01:11 INFO - "basedir": "/builds/slave/test", 10:01:11 INFO - "buildnumber": 4, 10:01:11 INFO - "slavename": "t-yosemite-r7-0004", 10:01:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:01:11 INFO - "platform": "yosemite_r7", 10:01:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:01:11 INFO - "branch": "mozilla-central", 10:01:11 INFO - "repo_path": "mozilla-central", 10:01:11 INFO - "revision": "720b9177c6856c1c4339d0fac1bf5149c0d53950", 10:01:11 INFO - "stage_platform": "macosx64", 10:01:11 INFO - "builduid": "243e6977b7e141909c00ea35e5476a7c", 10:01:11 INFO - "slavebuilddir": "test" 10:01:11 INFO - } 10:01:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:01:11 INFO - Running post-action listener: _resource_record_post_action 10:01:11 INFO - [mozharness: 2017-04-05 17:01:11.930182Z] Finished read-buildbot-config step (success) 10:01:11 INFO - [mozharness: 2017-04-05 17:01:11.930413Z] Running download-and-extract step. 10:01:11 INFO - Running pre-action listener: _resource_record_pre_action 10:01:11 INFO - Running main action method: download_and_extract 10:01:11 INFO - mkdir: /builds/slave/test/build/tests 10:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:11 INFO - trying https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:01:11 INFO - Downloading https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:01:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:01:12 INFO - Downloaded 1325 bytes. 10:01:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:01:12 INFO - Using the following test package requirements: 10:01:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:01:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:01:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:01:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:01:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'jsshell-mac.zip'], 10:01:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:01:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:01:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:01:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:01:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:01:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:01:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:01:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:01:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:01:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:01:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:01:14 INFO - Expected file size: 52519161 10:01:14 INFO - Obtained file size: 52519161 10:01:30 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:01:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:01:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:01:30 INFO - Fetch https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:01:33 INFO - Expected file size: 52519161 10:01:33 INFO - Obtained file size: 52519161 10:01:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:01:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:01:48 INFO - Fetch https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:01:49 INFO - Expected file size: 14404152 10:01:49 INFO - Obtained file size: 14404152 10:01:49 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')]} 10:01:49 INFO - trying https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:01:49 INFO - Downloading https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:01:51 INFO - Downloaded 70760279 bytes. 10:01:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:01:51 INFO - mkdir: /builds/slave/test/properties 10:01:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:01:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:01:51 INFO - Contents: 10:01:51 INFO - build_url:https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:01:52 INFO - Running post-action listener: _resource_record_post_action 10:01:52 INFO - Running post-action listener: set_extra_try_arguments 10:01:52 INFO - [mozharness: 2017-04-05 17:01:52.256896Z] Finished download-and-extract step (success) 10:01:52 INFO - [mozharness: 2017-04-05 17:01:52.257024Z] Running populate-webroot step. 10:01:52 INFO - Running pre-action listener: _resource_record_pre_action 10:01:52 INFO - Running main action method: populate_webroot 10:01:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:52 INFO - '--tppagecycles', 10:01:52 INFO - '7'], 10:01:52 INFO - 'tests': ['tsvgm']}}, 10:01:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:01:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:01:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:01:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['damp', 'tps']}, 10:01:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'tests': ['damp', 'tps']}, 10:01:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['dromaeo_dom']}, 10:01:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['basic_compositor_video']}, 10:01:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:01:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['a11yr', 10:01:52 INFO - 'ts_paint', 10:01:52 INFO - 'tpaint', 10:01:52 INFO - 'sessionrestore', 10:01:52 INFO - 'sessionrestore_no_auto_restore', 10:01:52 INFO - 'tabpaint']}, 10:01:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:01:52 INFO - 'ts_paint', 10:01:52 INFO - 'tpaint', 10:01:52 INFO - 'sessionrestore', 10:01:52 INFO - 'sessionrestore_no_auto_restore', 10:01:52 INFO - 'tabpaint']}, 10:01:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:01:52 INFO - 'ts_paint', 10:01:52 INFO - 'tpaint', 10:01:52 INFO - 'sessionrestore', 10:01:52 INFO - 'sessionrestore_no_auto_restore', 10:01:52 INFO - 'tabpaint']}, 10:01:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:01:52 INFO - 'ts_paint', 10:01:52 INFO - 'tpaint', 10:01:52 INFO - 'sessionrestore', 10:01:52 INFO - 'sessionrestore_no_auto_restore', 10:01:52 INFO - 'tabpaint']}, 10:01:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['a11yr', 10:01:52 INFO - 'ts_paint', 10:01:52 INFO - 'tpaint', 10:01:52 INFO - 'sessionrestore', 10:01:52 INFO - 'sessionrestore_no_auto_restore', 10:01:52 INFO - 'tabpaint']}, 10:01:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['a11yr', 10:01:52 INFO - 'ts_paint', 10:01:52 INFO - 'tpaint', 10:01:52 INFO - 'sessionrestore', 10:01:52 INFO - 'sessionrestore_no_auto_restore', 10:01:52 INFO - 'tabpaint']}, 10:01:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['tsvgx', 10:01:52 INFO - 'tsvgr_opacity', 10:01:52 INFO - 'tart', 10:01:52 INFO - 'tscrollx', 10:01:52 INFO - 'cart', 10:01:52 INFO - 'tsvg_static']}, 10:01:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:01:52 INFO - 'tsvgr_opacity', 10:01:52 INFO - 'tart', 10:01:52 INFO - 'tscrollx', 10:01:52 INFO - 'cart', 10:01:52 INFO - 'tsvg_static']}, 10:01:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'talos_options': ['--disable-e10s'], 10:01:52 INFO - 'tests': ['tp5o']}, 10:01:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:01:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'talos_options': ['--disable-e10s', 10:01:52 INFO - '--xperf_path', 10:01:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:52 INFO - 'tests': ['tp5n']}, 10:01:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:01:52 INFO - 'talos_options': ['--xperf_path', 10:01:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:52 INFO - 'tests': ['tp5n']}}, 10:01:52 INFO - 'talos.zip': {'path': '', 10:01:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:52 INFO - Running post-action listener: _resource_record_post_action 10:01:52 INFO - [mozharness: 2017-04-05 17:01:52.275595Z] Finished populate-webroot step (success) 10:01:52 INFO - [mozharness: 2017-04-05 17:01:52.275733Z] Running create-virtualenv step. 10:01:52 INFO - Running pre-action listener: _resource_record_pre_action 10:01:52 INFO - Running main action method: create_virtualenv 10:01:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:01:52 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 10:01:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:01:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:52 INFO - Using real prefix '/tools/python27' 10:01:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:01:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:55 INFO - Installing pip.................done. 10:01:55 INFO - Return code: 0 10:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:01:56 INFO - Reading from file tmpfile_stdout 10:01:56 INFO - Output received: 10:01:56 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) 10:01:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:01:56 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 10:01:56 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 10:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:56 INFO - 'HOME': '/Users/cltbld', 10:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PAGER': '/bin/cat', 10:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test', 10:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:01:56 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - 'XPC_FLAGS': '0x0', 10:01:56 INFO - 'XPC_SERVICE_NAME': '0', 10:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:56 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 10:01:56 INFO - Cleaning up... 10:01:56 INFO - Return code: 0 10:01:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:01:56 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 10:01:56 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 10:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:56 INFO - 'HOME': '/Users/cltbld', 10:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PAGER': '/bin/cat', 10:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test', 10:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:01:56 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - 'XPC_FLAGS': '0x0', 10:01:56 INFO - 'XPC_SERVICE_NAME': '0', 10:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:56 INFO - Downloading/unpacking psutil>=3.1.1 10:01:56 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 10:01:56 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 10:01:56 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 10:01:56 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 10:01:56 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 10:01:56 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 10:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:00 INFO - Installing collected packages: psutil 10:02:00 INFO - Running setup.py install for psutil 10:02:00 INFO - building 'psutil._psutil_osx' extension 10:02:00 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 10:02:00 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 10:02:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:02:01 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 10:02:01 INFO - building 'psutil._psutil_posix' extension 10:02:01 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 10:02:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:02:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:02:01 INFO - ^ 10:02:01 INFO - 1 warning generated. 10:02:01 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 10:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:01 INFO - Successfully installed psutil 10:02:01 INFO - Cleaning up... 10:02:01 INFO - Return code: 0 10:02:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:02:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:02 INFO - 'HOME': '/Users/cltbld', 10:02:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:02 INFO - 'LOGNAME': 'cltbld', 10:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:02 INFO - 'MOZ_NO_REMOTE': '1', 10:02:02 INFO - 'NO_EM_RESTART': '1', 10:02:02 INFO - 'PAGER': '/bin/cat', 10:02:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:02 INFO - 'PWD': '/builds/slave/test', 10:02:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:02 INFO - 'SHELL': '/bin/bash', 10:02:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:02 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:02 INFO - 'USER': 'cltbld', 10:02:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:02 INFO - 'XPC_FLAGS': '0x0', 10:02:02 INFO - 'XPC_SERVICE_NAME': '0', 10:02:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:02 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 10:02:02 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 10:02:02 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 10:02:02 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 10:02:02 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 10:02:02 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 10:02:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:05 INFO - Installing collected packages: mozsystemmonitor 10:02:05 INFO - Running setup.py install for mozsystemmonitor 10:02:05 INFO - Successfully installed mozsystemmonitor 10:02:05 INFO - Cleaning up... 10:02:05 INFO - Return code: 0 10:02:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:02:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:05 INFO - 'HOME': '/Users/cltbld', 10:02:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:05 INFO - 'LOGNAME': 'cltbld', 10:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:05 INFO - 'MOZ_NO_REMOTE': '1', 10:02:05 INFO - 'NO_EM_RESTART': '1', 10:02:05 INFO - 'PAGER': '/bin/cat', 10:02:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:05 INFO - 'PWD': '/builds/slave/test', 10:02:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:05 INFO - 'SHELL': '/bin/bash', 10:02:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:05 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:05 INFO - 'USER': 'cltbld', 10:02:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:05 INFO - 'XPC_FLAGS': '0x0', 10:02:05 INFO - 'XPC_SERVICE_NAME': '0', 10:02:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:06 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:09 INFO - warning: no files found matching '*.txt' 10:02:09 INFO - no previously-included directories found matching 'build' 10:02:09 INFO - no previously-included directories found matching 'dist' 10:02:09 INFO - no previously-included directories found matching '.git*' 10:02:09 INFO - Installing collected packages: jsonschema, functools32 10:02:09 INFO - Running setup.py install for functools32 10:02:09 INFO - warning: no files found matching '*.txt' 10:02:09 INFO - no previously-included directories found matching 'build' 10:02:09 INFO - no previously-included directories found matching 'dist' 10:02:09 INFO - no previously-included directories found matching '.git*' 10:02:09 INFO - Successfully installed jsonschema functools32 10:02:09 INFO - Cleaning up... 10:02:09 INFO - Return code: 0 10:02:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:02:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:09 INFO - 'HOME': '/Users/cltbld', 10:02:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:09 INFO - 'LOGNAME': 'cltbld', 10:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:09 INFO - 'MOZ_NO_REMOTE': '1', 10:02:09 INFO - 'NO_EM_RESTART': '1', 10:02:09 INFO - 'PAGER': '/bin/cat', 10:02:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:09 INFO - 'PWD': '/builds/slave/test', 10:02:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:09 INFO - 'SHELL': '/bin/bash', 10:02:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:09 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:09 INFO - 'USER': 'cltbld', 10:02:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:09 INFO - 'XPC_FLAGS': '0x0', 10:02:09 INFO - 'XPC_SERVICE_NAME': '0', 10:02:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:09 INFO - Cleaning up... 10:02:09 INFO - Return code: 0 10:02:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:02:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:09 INFO - 'HOME': '/Users/cltbld', 10:02:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:09 INFO - 'LOGNAME': 'cltbld', 10:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:09 INFO - 'MOZ_NO_REMOTE': '1', 10:02:09 INFO - 'NO_EM_RESTART': '1', 10:02:09 INFO - 'PAGER': '/bin/cat', 10:02:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:09 INFO - 'PWD': '/builds/slave/test', 10:02:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:09 INFO - 'SHELL': '/bin/bash', 10:02:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:09 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:09 INFO - 'USER': 'cltbld', 10:02:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:09 INFO - 'XPC_FLAGS': '0x0', 10:02:09 INFO - 'XPC_SERVICE_NAME': '0', 10:02:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:13 INFO - Downloading docopt-0.6.1.tar.gz 10:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:14 INFO - Running setup.py install for blobuploader 10:02:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:14 INFO - Running setup.py install for requests 10:02:14 INFO - Running setup.py install for docopt 10:02:14 INFO - Successfully installed blobuploader requests docopt 10:02:14 INFO - Cleaning up... 10:02:14 INFO - Return code: 0 10:02:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:14 INFO - 'HOME': '/Users/cltbld', 10:02:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:14 INFO - 'LOGNAME': 'cltbld', 10:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:14 INFO - 'MOZ_NO_REMOTE': '1', 10:02:14 INFO - 'NO_EM_RESTART': '1', 10:02:14 INFO - 'PAGER': '/bin/cat', 10:02:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:14 INFO - 'PWD': '/builds/slave/test', 10:02:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:14 INFO - 'SHELL': '/bin/bash', 10:02:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:14 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:14 INFO - 'USER': 'cltbld', 10:02:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:14 INFO - 'XPC_FLAGS': '0x0', 10:02:14 INFO - 'XPC_SERVICE_NAME': '0', 10:02:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-I3VtOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ddI2_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-iYQPpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-9o2FQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-iVlezI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Jyxv7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-BCPmyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-c4xrzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-zKTEyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-6bOwwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ymuZol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-FnapTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-D7Yh9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Cko1Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-hPmiaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-II820C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:16 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-4IreW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:16 INFO - Running setup.py install for manifestparser 10:02:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:17 INFO - Running setup.py install for mozcrash 10:02:17 INFO - Running setup.py install for mozdebug 10:02:17 INFO - Running setup.py install for mozdevice 10:02:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:17 INFO - Running setup.py install for mozfile 10:02:17 INFO - Running setup.py install for mozhttpd 10:02:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:17 INFO - Running setup.py install for mozinfo 10:02:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:17 INFO - Running setup.py install for mozInstall 10:02:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Running setup.py install for mozleak 10:02:18 INFO - Running setup.py install for mozlog 10:02:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Running setup.py install for moznetwork 10:02:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Running setup.py install for mozprocess 10:02:18 INFO - Running setup.py install for mozprofile 10:02:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:18 INFO - Running setup.py install for mozrunner 10:02:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:19 INFO - Running setup.py install for mozscreenshot 10:02:19 INFO - Running setup.py install for moztest 10:02:19 INFO - Running setup.py install for mozversion 10:02:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:19 INFO - Cleaning up... 10:02:19 INFO - Return code: 0 10:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:02:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:19 INFO - 'HOME': '/Users/cltbld', 10:02:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:19 INFO - 'LOGNAME': 'cltbld', 10:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:19 INFO - 'MOZ_NO_REMOTE': '1', 10:02:19 INFO - 'NO_EM_RESTART': '1', 10:02:19 INFO - 'PAGER': '/bin/cat', 10:02:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:19 INFO - 'PWD': '/builds/slave/test', 10:02:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:19 INFO - 'SHELL': '/bin/bash', 10:02:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:19 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:19 INFO - 'USER': 'cltbld', 10:02:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:19 INFO - 'XPC_FLAGS': '0x0', 10:02:19 INFO - 'XPC_SERVICE_NAME': '0', 10:02:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:19 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-jk_g7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:19 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ZX_y5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:19 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ecRMiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-M88lxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Lxw7Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-PWuvos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-CZ6tIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-gWia3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-riXr59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-o0GNM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-GVk2tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:20 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ezEL29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:21 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-TkmP_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:21 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-u0Me7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:21 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-3BXU1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:21 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-NIIALe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:21 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-oQLyeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:02:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:24 INFO - Downloading blessings-1.6.tar.gz 10:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:24 INFO - Installing collected packages: blessings 10:02:24 INFO - Running setup.py install for blessings 10:02:24 INFO - Successfully installed blessings 10:02:24 INFO - Cleaning up... 10:02:24 INFO - Return code: 0 10:02:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:24 INFO - Reading from file tmpfile_stdout 10:02:24 INFO - Current package versions: 10:02:24 INFO - blessings == 1.6 10:02:24 INFO - blobuploader == 1.2.4 10:02:24 INFO - docopt == 0.6.1 10:02:24 INFO - functools32 == 3.2.3-2 10:02:24 INFO - jsonschema == 2.5.1 10:02:24 INFO - manifestparser == 1.1 10:02:24 INFO - mozInstall == 1.12 10:02:24 INFO - mozcrash == 1.0 10:02:24 INFO - mozdebug == 0.1 10:02:24 INFO - mozdevice == 0.49 10:02:24 INFO - mozfile == 1.2 10:02:24 INFO - mozhttpd == 0.7 10:02:24 INFO - mozinfo == 0.9 10:02:24 INFO - mozleak == 0.1 10:02:24 INFO - mozlog == 3.4 10:02:24 INFO - moznetwork == 0.27 10:02:24 INFO - mozprocess == 0.25 10:02:24 INFO - mozprofile == 0.28 10:02:24 INFO - mozrunner == 6.13 10:02:24 INFO - mozscreenshot == 0.1 10:02:24 INFO - mozsystemmonitor == 0.3 10:02:24 INFO - moztest == 0.8 10:02:24 INFO - mozversion == 1.4 10:02:24 INFO - psutil == 3.1.1 10:02:24 INFO - requests == 1.2.3 10:02:24 INFO - wsgiref == 0.1.2 10:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:24 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 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:24 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 10:02:24 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 10:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:24 INFO - 'HOME': '/Users/cltbld', 10:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:24 INFO - 'LOGNAME': 'cltbld', 10:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:24 INFO - 'MOZ_NO_REMOTE': '1', 10:02:24 INFO - 'NO_EM_RESTART': '1', 10:02:24 INFO - 'PAGER': '/bin/cat', 10:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:24 INFO - 'PWD': '/builds/slave/test', 10:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:24 INFO - 'SHELL': '/bin/bash', 10:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:24 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:24 INFO - 'USER': 'cltbld', 10:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:24 INFO - 'XPC_FLAGS': '0x0', 10:02:24 INFO - 'XPC_SERVICE_NAME': '0', 10:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:02:25 INFO - Cleaning up... 10:02:25 INFO - Return code: 0 10:02:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c0abb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0ae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff47b594f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, '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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 10:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:02:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:25 INFO - 'HOME': '/Users/cltbld', 10:02:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:25 INFO - 'LOGNAME': 'cltbld', 10:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:25 INFO - 'MOZ_NO_REMOTE': '1', 10:02:25 INFO - 'NO_EM_RESTART': '1', 10:02:25 INFO - 'PAGER': '/bin/cat', 10:02:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:25 INFO - 'PWD': '/builds/slave/test', 10:02:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:25 INFO - 'SHELL': '/bin/bash', 10:02:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:25 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:25 INFO - 'USER': 'cltbld', 10:02:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:25 INFO - 'XPC_FLAGS': '0x0', 10:02:25 INFO - 'XPC_SERVICE_NAME': '0', 10:02:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:25 INFO - Cleaning up... 10:02:25 INFO - Return code: 0 10:02:25 INFO - Running post-action listener: _resource_record_post_action 10:02:25 INFO - Running post-action listener: _start_resource_monitoring 10:02:25 INFO - Starting resource monitoring. 10:02:25 INFO - [mozharness: 2017-04-05 17:02:25.437527Z] Finished create-virtualenv step (success) 10:02:25 INFO - [mozharness: 2017-04-05 17:02:25.438459Z] Running install step. 10:02:25 INFO - Running pre-action listener: _resource_record_pre_action 10:02:25 INFO - Running main action method: install 10:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:25 INFO - Reading from file tmpfile_stdout 10:02:25 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:25 INFO - Reading from file tmpfile_stdout 10:02:25 INFO - Output received: 10:02:25 INFO - Usage: mozinstall [options] installer 10:02:25 INFO - Options: 10:02:25 INFO - -h, --help show this help message and exit 10:02:25 INFO - -d DEST, --destination=DEST 10:02:25 INFO - Directory to install application into. [default: 10:02:25 INFO - "/builds/slave/test"] 10:02:25 INFO - --app=APP Application being installed. [default: firefox] 10:02:25 INFO - mkdir: /builds/slave/test/build/application 10:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:02:45 INFO - Reading from file tmpfile_stdout 10:02:45 INFO - Output received: 10:02:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:02:45 INFO - Running post-action listener: _resource_record_post_action 10:02:45 INFO - [mozharness: 2017-04-05 17:02:45.555871Z] Finished install step (success) 10:02:45 INFO - [mozharness: 2017-04-05 17:02:45.555997Z] Running run-tests step. 10:02:45 INFO - Running pre-action listener: _resource_record_pre_action 10:02:45 INFO - Running main action method: run_tests 10:02:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:02:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:02:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:02:45 INFO - 2017-04-05 10:02:45.569 screenresolution[1633:7557] starting screenresolution argv=screenresolution get 10:02:45 INFO - 2017-04-05 10:02:45.571 screenresolution[1633:7557] Display 0: 1600x1200x32@60 10:02:45 INFO - 2017-04-05 10:02:45.577 screenresolution[1634:7560] starting screenresolution argv=screenresolution list 10:02:45 INFO - Available Modes on Display 0 10:02:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:02:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:02:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:02:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:02:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:02:45 INFO - Intel Iris: 10:02:45 INFO - Chipset Model: Intel Iris 10:02:45 INFO - Type: GPU 10:02:45 INFO - Bus: Built-In 10:02:45 INFO - VRAM (Dynamic, Max): 1536 MB 10:02:45 INFO - Vendor: Intel (0x8086) 10:02:45 INFO - Device ID: 0x0a2e 10:02:45 INFO - Revision ID: 0x0009 10:02:45 INFO - Displays: 10:02:45 INFO - Display: 10:02:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:02:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:02:45 INFO - Display Serial Number: 1600x1200 60 10:02:45 INFO - Main Display: Yes 10:02:45 INFO - Mirror: Off 10:02:45 INFO - Online: Yes 10:02:45 INFO - Rotation: Supported 10:02:45 INFO - Return code: 0 10:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:45 INFO - Python 2.7.3 10:02:45 INFO - Return code: 0 10:02:45 INFO - grabbing minidump binary from tooltool 10:02:45 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')]} 10:02:45 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 0x10be89d30>, '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 0x10bdb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be7ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:45 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 10:02:45 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 10:02:45 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 10:02:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:45 INFO - Return code: 0 10:02:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:02:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:45 INFO - ENV: RUST_BACKTRACE is now 1 10:02:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:02:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--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 10:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0004 --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 10:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gDMERQ5I1c/Render', 10:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:02:45 INFO - 'HOME': '/Users/cltbld', 10:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:02:45 INFO - 'LOGNAME': 'cltbld', 10:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:45 INFO - 'MOZ_NO_REMOTE': '1', 10:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:45 INFO - 'NO_EM_RESTART': '1', 10:02:45 INFO - 'PAGER': '/bin/cat', 10:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:45 INFO - 'PWD': '/builds/slave/test', 10:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:02:45 INFO - 'RUST_BACKTRACE': '1', 10:02:45 INFO - 'SHELL': '/bin/bash', 10:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1g76O5Ifnj/Listeners', 10:02:45 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 10:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:02:45 INFO - 'USER': 'cltbld', 10:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:45 INFO - 'XPC_FLAGS': '0x0', 10:02:45 INFO - 'XPC_SERVICE_NAME': '0', 10:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:02:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--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 10:02:46 INFO - mozversion application_buildid: 20170405081820 10:02:46 INFO - mozversion application_changeset: 720b9177c6856c1c4339d0fac1bf5149c0d53950 10:02:46 INFO - mozversion application_display_name: Nightly 10:02:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:46 INFO - mozversion application_name: Firefox 10:02:46 INFO - mozversion application_remotingname: firefox 10:02:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:46 INFO - mozversion application_vendor: Mozilla 10:02:46 INFO - mozversion application_version: 55.0a1 10:02:46 INFO - mozversion platform_buildid: 20170405081820 10:02:46 INFO - mozversion platform_changeset: 720b9177c6856c1c4339d0fac1bf5149c0d53950 10:02:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:46 INFO - mozversion platform_version: 55.0a1 10:02:46 INFO - using testdate: 1491411766 10:02:46 INFO - actual date: 1491411766 10:02:46 INFO - starting webserver on 'localhost:49248' 10:02:46 INFO - SUITE-START | Running 2 tests 10:02:46 INFO - TEST-START | dromaeo_css 10:02:46 INFO - operating with platform_type : mac_ 10:02:46 INFO - Initialising browser for dromaeo_css test... 10:02:46 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmpLV5HVu/profile http://localhost:49248/getInfo.html) 10:02:48 INFO - PID 1644 | __metrics Screen width/height:1600/1200 10:02:48 INFO - PID 1644 | colorDepth:24 10:02:48 INFO - PID 1644 | Browser inner width/height: 1024/689 10:02:48 INFO - PID 1644 | __metrics 10:02:49 INFO - PID 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:02:49 INFO - PID 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:02:50 INFO - TEST-INFO | 1644: exit 0 10:02:50 INFO - Browser initialized. 10:02:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:50 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmpLV5HVu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:02 INFO - PID 1646 | RSS: Main: 238891008 10:03:02 INFO - PID 1646 | 10:06:08 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 10:06:10 INFO - PID 1646 | RSS: Main: 391507968 10:06:10 INFO - PID 1646 | 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 10:07:52 INFO - PID 1646 | 10:07:52 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:07:52 INFO - PID 1646 | Full stack: 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 10:07:52 INFO - PID 1646 | 10:07:52 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:07:52 INFO - PID 1646 | Full stack: 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 10:07:52 INFO - PID 1646 | 10:07:52 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:07:52 INFO - PID 1646 | Full stack: 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | ************************* 10:07:52 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 10:07:52 INFO - PID 1646 | 10:07:52 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:07:52 INFO - PID 1646 | Full stack: 10:07:52 INFO - PID 1646 | ************************* 10:09:13 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 10:09:13 INFO - PID 1646 | RSS: Main: 367804416 10:09:13 INFO - PID 1646 | 10:12:16 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:12:16 INFO - PID 1646 | RSS: Main: 329625600 10:12:16 INFO - PID 1646 | 10:15:19 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:15:19 INFO - PID 1646 | RSS: Main: 331673600 10:15:19 INFO - PID 1646 | 10:18:23 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:18:24 INFO - PID 1646 | RSS: Main: 328683520 10:18:24 INFO - PID 1646 | 10:21:26 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:21:27 INFO - PID 1646 | RSS: Main: 422678528 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | __start_tp_report 10:21:27 INFO - PID 1646 | _x_x_mozilla_page_load 10:21:27 INFO - PID 1646 | _x_x_mozilla_page_load_details 10:21:27 INFO - PID 1646 | |i|pagename|runs| 10:21:27 INFO - PID 1646 | |0;dojo.html;2902.8113172643775;3510.140015696155;3516.8241587920597;3553.6091029986696;3582.6238244984274;6170.290416602092;6224.533160013;6240.719167637456;6273.964795808692;6286.654234017127;6154.753809847612;6192.071189321604;6215.937840621593;6283.968580157093;6284.937150628492;4982.9252561211615;5309.283246761676;5388.380336261341;5408.540274076709;5544.0575102232715;5452.04589196889;5500.6424582402215;5506.149479659425;5506.449355064502;5518.530924871371;5297.311349524575;5350.705711185883;5365.061114304981;5373.543248823855;5378.946210537883;5363.517283444469;5373.086575282172;5393.7303134843105;5406.405295417501;5413.377461591888;5311.123664595337;5353.919691204596;5356.303680521507;5369.301990741218;5381.973090134525;6134.2529056856065;6137.358988059849;6137.570370074097;6146.647737497743;6149.323574406856;6522.869542609121;6551.93448065518;6570.310117437648;6620.437262832616;6635.6682165892;6717.664116794141;6734.696938637773;6736.292689267654;6745.156855393076;6751.25736169021;6144.354842741537;6317.684115794238;6324.588901721373;6335.3981371769605;6350.618962862243;6673.933260667428;6698.83252918681;6779.15260592426;6859.794206173823;6891.517593768488;6329.113924050636;6414.102025716404;6429.710663020175;6450.580712253689;6546.0508226307875;6687.164104486939;6707.899381509281;6713.597184168965;6718.428933540606;6727.327267273234;6582.901256481156;6599.1091202687985;6612.570182938093;6614.338566143347;6616.470682345497;6352.555321127569;6435.903461448082;6438.195225596801;6441.549091563639;6609.636469994197;5145.099607568661;5309.41596424393;5311;5311.389190243094;5312.654677445954;4660.813567457331;4719.716816990992;4760.476347601761;4790.688605240648;4824.300476430968;6250.062490626351;6344.333844946306;6360.809175724736;6367.52243581724;6368.808935731843;6695.296993815579;6699.330066993261;6715.496337774686;6722.563033402911;6725.596464212163;6184.134221209034;6273.905891411632;6357.841053973688;6370.872582548323;6381;5836.88326233473;5844.211031510692;5847.6783776891825;5849.151872978395;5868.765249390062;6849.1096157499205;6854.143232095988;6854.417374523022;6870.793876183722;6936.7225310987;6684.197896252481;6717.630530320879;6725.697343619647;6731.932680673131;6733.865322693421;6982.8840137882935;7006.124234470692;7017;7025.543339682904;7062.4703147263135;6301.991681330965;6398.616083035033;6439.613623182624;6614.636195009129;6616.503762217757;6512.902306465312;6583.604983700993;6636.070950067091;6646.767363142267;6697.899531506934;6471.191101112361;6495.317991610813;6496.220453545605;6503.804885853432;6506.544541882023;6478.967605161944;6480.351964803482;6487.837804054936;6494.935050649433;6502.252240992347;6280.277768056732;6308.463780578702;6333.36666333363;6370.044493326038;6376.075469056868;6449.097126402214;6470.417662410406;6492.188476440445;6499.415052645285;6502.837429064311;6319.652419116993;6338.144350512622;6342.460890824147;6355.7775477859905;6381.361863813767 10:21:27 INFO - PID 1646 | |1;ext.html;749.9662515186816;793.2900054451267;813.9348852091833;1142.2917790969595;1164.7961606718823;27533.44933101339;37372.252554948886;38114.99999999996;38149.23701525968;38214.42678359827;35117;37671.623283767156;39729;40082.59917400825;40332;8495.660173593064;8671.349648776335;8677.913220867806;8694;8715.694950676727;6118.143459915593;6275.874482510347;8480.151984801501;8682.348823838205;8709.34679899007;8639.006514250847;8754.6935857245;8767.956160219223;8769.035406105324;8774.605142768558;8688.56557172142;8714.520701361422;8743.868841967344;8749.606267717969;8755.693550725759;8413.873791893126;8473.576321183917;8479.491230526126;8490.66037358505;8505.489670619783;37954.81022594897;38178;38246.80876595627;38308.42537361914;38387;3422.401079811023;3442.915481623306;3446.724262059029;3458.9308213835584;3464.9133771655656;30794.92217772367;30803.691963080306;30826;30871.691283087108;30890.536641950388;2956.8669409876393;3012.2469382654335;3100.829454380008;3100.9766776963547;3119.5788568543185;262174;339357;346723;349355;350682;48764.75617621889;48774.90313710786;48979;49030;49079.754601227476;50856.49143508592;50873.982520350124;50876.49123508792;50898;51049.46851594458;14100.294985250697;14238.572842814732;14242.43030278798;14420.495282665057;14482.493112741004;11656.358900260568;11680.474378652982;11687.532498699957;11697.23967942081;11697.649070527897;11648.475818588184;11850.11124165691;11854.525818967317;11859.940700296444;11895.405229738479;5017.598592112622;5609.354924183689;5727.4845263926445;5735.311762588432;5736.42635736423;824.6989848705299;966.1497881863914;980.8087422952599;989.7278248481725;1019.2253887045898;22750.203742868922;24140.758592414204;24150.637740433907;24158.51682966331;24280.63579046316;1068.7435015596357;1073.7423018475665;1118.139032944628;1121.4448847820381;1134.7219931116929;10461.74459064917;11449.427528623535;11717.179797414099;12406.81389779154;12438.378081095909;492620;496331.51834240597;497287;497324;498592.028159442;55766.72116639391;55891.44108558944;56175.719121404945;56187.71906140525;56274;1454.614527150306;1471.1687896338321;1515.9085458469883;1518.3622878391102;1530.1278271385427;23462.296131116094;23550.114231151667;23626.52746945017;23631;23705;38981;39052;39105.80447097746;39130;39232;441804;443161.784191077;443493;443823;444246;32060;32775.67224327726;32798.836005819816;32926.83536582302;32940;42625;42650.93372665708;42827.78586107049;43491.78254108836;43507.129857403306;28828.42343153167;29404;29523.704762952097;29901.551476728302;29991.950281740035;29002.7099729;29595;30001.849990749906;30177.396452071276;30341.69658303389;35688.64311356957;36373.45439818458;36442.63557364392;36626.633733662326;36689.63310366969;30143.547846782756;30338;30438.239044024078;31159.53260701046;31225.37549249048;22515.874206289947;24133.155339563033;24139.758602414455;24597.38506537351;24717 10:21:27 INFO - PID 1646 | |2;jquery.html;389.7310855509696;430.4804041732685;434.6848534812261;443.37705523739146;460.606181714634;18742;21482.570348593017;21862.797546134956;22611.434714132156;23525.41186470339;23240.883795580998;23528.88235558824;23899.522009559798;24228.878855605697;24261.514769704638;4619.030003699228;6224.96887515563;6416.679166041703;6423.80728578141;6435.066915297279;6265.154204182422;6265.9686701566425;6373.298937116913;6375.139356186925;6381.7766378176775;5691.630044047144;6246;6263.436290733833;6275.937240627603;6296.859067916907;6121.908171377433;6221.657808820513;6246.531510136735;6280.591761535508;6350.396712312346;5611.186377975171;5616.269884914935;5621.943780562183;5622;5627.71861406928;27807.721922780715;28032.719672803214;28130.015449459377;28192;28420.715792842013;2081.261152290945;2170.5007848195005;2175.8368122390884;2216.213244298283;2244.7867452591977;15572.766408503881;17229.913850430792;17948.923064616036;18297.542561436072;18598.16308266131;2115.375964090597;2126.5008169240805;2131.296672098204;2158.557495713375;2163.945901352463;139467.30266348706;167046;168706.15646921686;168822;169528;9084.682036128705;10628.25602207838;12704.301263430416;12768.425420856083;12855.871441285468;15680.137592432526;17134.14329283531;17139.828601713823;17166.05586692744;17178.570535736457;7260.709571617076;8723.171298726611;8874.511901845332;9006.234470070118;9129.45223286605;8434.28308593764;8437;8446.788830279293;8604.48373097616;8616.698415555426;7949.284564389232;8059.274665280153;8161.469504482189;8172.264496195371;8177.67289308421;1854.1736389656178;2106.147010460735;2112.376848829599;2113.3765539165984;2271.0575111328612;891.6076926152472;907.419251678926;909.6088681866728;949.231122790528;955.603424578792;20559.897200514202;21490.677639835416;21506.247281345077;21511.67732484014;21550.461238469165;884.6638277454526;964.6189755046857;965.82615129276;967.6018153767878;994.1599348550463;9190.632374704937;11034.393108378956;11085.390303533382;11109;11112.666620001413;621032;701301;703590;716617;721804;154815;156733.0816729591;158832;161153.19423402808;161849;1016.8220561401578;1166.597523854269;1171.0088691795947;1233.858106317767;1238.659368673604;19931.800681992994;21051.368458946257;22990.93081622662;23090;23750.643740344254;57132.714336429715;57948.710256448445;59282.70358648179;59835.10247346206;59854.70072649609;59869;79501.2049879517;79689.60155199187;79775;80565.59717201376;8702.782430439289;8741.300695944436;8813.118688131135;9291.024442433447;9305.813883722423;11912.940435297767;12614.243145411305;14420.639484012983;14680.706385872436;14943.402263909322;11929.82105268439;12090.939545302217;12173.513059477877;12310.015198783896;12313.076519260912;9715.9028409715;11467.31196128235;11515.712107197052;11716.121290903387;11753.941230293794;11564.710882228012;11580.378746975599;11846.644600661994;12252.142350035412;12322.50709971627;8688.91311086881;9089.772880661027;9108.635654574007;9252.398594091363;9328.160465558132;11587.478563464832;11715.589954351557;12032.819507707567;12079.75840483203;12127.81808272859 10:21:27 INFO - PID 1646 | |3;mootools.html;1327.5088217359576;1414.8868090552758;1430.1276221504884;1432.5415866922583;1436.037854637393;11229;11751.529938802449;11766.823497647541;11772.352520611374;11812.995895348906;10783.191260655463;11466.48400821963;11880.28718276904;11905.92846643802;11923.344216068113;2075.802798734125;2557.5012872489874;2561.346856551586;2562.167295628928;2563.102913980101;2466.1984854922134;2483.4412257242157;2533.518631460017;2539.098619989905;2541.0471073347494;2435.2450740270483;2539.987300063506;2541.3392517945376;2543.1988923489043;2545.2491515003117;2465.3466831289725;2506.135383292761;2517.5845985412475;2548.4266040141006;2549.6685430893867;2491.813114016456;2512.8115391345723;2521.470491196851;2522.369407648088;2525.02786427225;11481.942590287079;11696.766064678744;11731.88268117325;11745.941270293593;11751.7062073448;6494.350564943515;6746.93253067468;6746.966265168692;6758.459323254128;6785.457163426914;4038.6720528544015;4218.1985422769885;4307.892302692458;4322.243607368698;4382.671299652538;1168.0713832503181;1193.934333611651;1204.777116233491;1252.6868282929267;1286.2668279080929;14840.851591484055;15295.923520382326;15330.15684137372;15941;16067.517974460668;5380.865478363072;5464.617476776667;5665.461781130868;5672.801451949162;5697.629654072555;12030.27818330903;12054.939725301492;12075.3358565278;12084.879151208552;12087.637370878712;5709.914351284734;5984.042553191469;6592.703328350236;6612.7354905804195;6615.437687796495;5129.8201413674315;5327.360716713942;5427.755750991215;5490.615656903979;6221.782237621662;3664.2854643344826;4242.257604919127;4299.011227417712;4342.305231162999;4405.9559404405545;1270.1172684984033;1274.8278982337265;1275.1647670775658;1296.9805452918213;1299.4471606430225;673.6526946107784;760.8744557148009;768.8885111658778;770.1451388958252;770.7495064104188;5886.793962211388;5940.049592065248;6110.969445152746;6137.815865524041;6153.969230153821;489.307629703972;563.5097465205216;589.8613825750945;606.4269265544018;607.0439058482907;3767.7550959188115;3912.374020156818;4197.929527970348;4204.4324016257415;4226.1758957003085;14338.56984290473;14951.87860910436;15016.849831501764;15035.097894126387;15046.849531504764;14870.256487175815;14917.552473425814;14919.568499245017;14921.626959325886;14931.17878516692;8665.523396213142;9372.812543749087;10225.335353202017;10837.024667779937;10866.293690910225;5395.70323632204;6221.813345599639;6796.864062718817;6946.548474349152;7002.054722612382;10781.24531282834;12614.49542018309;12911.483540658268;12930.612081637566;13004.414801334153;13767.311634418038;13865.306734663025;14008.019438639198;14095.295235237993;14221.360038798071;8439.789005274917;8445.873311900203;8449.577521124042;8555.700550480704;8559.871601926101;9770.413775173512;9989.100980911753;9989.750256243651;9994.500274986367;10030.498475076363;8758.255548278214;8964.417312874642;8973.865392018994;9056.184943355129;9155.176034156957;7232.770429026973;8783.341249406449;8806.823863522823;8825.69110081144;8951.776205594912;7530.966639007547;7925.564093974886;7928.484648497829;7933.404994625311;7938.206179382016;5764.682942438206;5837.241158649348;5972.223610930551;6047.123167140828;6078.209832721718;5905.852353691193;5989;6074.331823499323;6159.384061593984;6300.180976473029 10:21:27 INFO - PID 1646 | |4;prototype.html;334.7205083755064;360.4143267190815;391.37184818366524;404.31670476894067;405.7524909805018;4843.5882949949255;5916.437938395851;5935.851603709904;5936;5938.317093534245;5195.870103247421;5799.391063938289;5804.82585522435;5840.941590584093;5845;4382.693211475198;4418.668599855007;4463.821447142111;4477.48508921475;4482.775861206943;3677.52192215013;4463.375127482155;4475.216837053519;4487.775611219442;4507.752073635948;3641.6904563112034;4148.81758698771;4434.512203657595;4448.221561226788;4471.53048929861;3512.701420379271;3566.769464534744;4211.031462763566;4285.314349704064;4293.4203882476095;3732.496113024734;3734.421164719473;3737.289914916157;3745.382011968022;3749.643783840531;4654.813807447698;5675.886482270332;5697.715114244271;5724.8855022899725;5739.282589676291;4838.620993017009;4996.600271978269;5083.822066227664;5094.439611642716;5106.183010718267;6160.84597885052;6182.783602573888;6188.226471691039;6193.3496982816605;6203.565750397474;3695.722820788452;4043.433919251307;4217.746935183868;4218.6835987300765;4221.87334379966;4691.5308469152815;6046.455818976269;6196.380361963767;6377.202849643794;6388.7125079371535;3905.6680182184264;4145.834166633361;4219.177260434186;4226.640735537452;4228.936565951513;3944.7041471889725;4160.918161278089;4287.871363859027;4292.570742925683;4303.289957157097;3981.203759248162;4018.9397159042637;4430.379746835446;5015.623828212899;5039.546440820343;5408.702521361363;6219.626822390671;6250.593711408835;6256.749730010749;6259.968700156561;1236.3694515796828;1463.6999415119874;1482.629342664334;1486.3385793321868;1488.9949284233098;934.8335185511968;980.0836218136066;990.1187942730975;990.8414653655525;1007.6322142417964;4905.23968784839;5427.453175844866;5893.528517718572;5907.556933230025;5927.762889484372;6425.903361764211;6449.838754031093;6464.709088091047;6473.449756770728;6486.870262594722;4884.242942343943;4980.452150263468;5209.453007434241;5404.8113810742125;5853.385394533598;3306.93386132276;3330.900072997814;3331.53358529806;3336.299377130781;3357.6642335766714;6430.356964303533;6456.630904521344;6626.337366263431;6628.072069910217;6716.832079197961;5570.97214513933;5648.9717551412805;5751.447109280471;6460.806175814639;6615.239247486601;6366.6180029198395;6369.681515924185;6625.701843417058;6648.434883034996;6663.5002374821115;5125.8466844959585;5672.298310506749;6005.339412664691;6360;6372.87254254903;5177.275181474522;5459.143891077053;6319.778807741707;6324.209473815773;6334;5405.324334458192;5459.2902922619805;6456.806295811133;6671.099401580918;6744;3516.8593256270487;4257.893552661209;4263.467066616673;4269.295566231661;4281.614654681093;5273.235380869829;6475.935240647722;6489.415952564292;6502.642354670538;6505.78803206893;5875.853103672443;6096;6119.84700382494;6207.224096987877;6207.299824576143;4819.662623616454;5500.339959204921;6232.657203853832;6235.937640623717;6244.313125556276;5292.788288468572;5512.448755124456;6045.879082418239;6101.237345331833;6114.877702446015;4714.81140754366;5232.148479078987;6041.728122234598;6165.181271524822;6233.906491402542;5400.269767350262;6037.882991646559;6088.573799833969;6099.4815440688035;6124.510039196943 10:21:27 INFO - PID 1646 | |5;yui.html;737.3400806278381;806.5926707012958;828.6768160417442;836.6402446947814;842.0695131879271;16051.357945682174;16412.753808692865;16424.343026278933;16451.177441127955;16460.75308870365;14634.04878682885;15066.945313828037;15242.237888105577;15579.84420155798;15740.134292613902;775.3448336155939;974.0600320690514;989.0505115089522;992.8758905136858;994.1798016636268;1006.5671761142705;1017.4302390661217;1019.5513973851519;1020.6223697231998;1023.5905637744887;1065.6110519660308;1066.3761699405857;1067.236925598197;1068.1188019883627;1069.6790962711154;1062.282959002674;1065.8561094252293;1065.9467026648636;1067.3009178987775;1068.1668298727006;780.2275747010475;784.1100351101484;784.1217836023633;784.3685832904509;785.6857257097207;16025.839741602667;16180.595485112848;16282.51152465416;17174.74237886433;17239.31042758288;11614.419279036014;14803.40786368544;14812.851871481254;14853.48012819557;14901.776473352907;12341.568045118378;12801.295928723917;13380.665483362896;13394.933025334909;13515.121517101357;3406.863725450979;3440.913977150566;3442.8278586070596;3444.4661077533024;3453.4301840196335;108899.45550272278;109141;110902.33646495308;110944;111836.99999999919;11456.19806613529;11466.2546934449;11492.655220343404;11496.942515287537;11552.884471155348;24351.14770983007;24715.62926556103;24921.75078249194;25136.622950655754;25193;7718.382529397747;7727.884081738778;7782.416318776114;7896.7236146734585;7935.56354400502;4060.2285565742413;4083.612056854594;4089.7137200395687;4111.075008123148;4145.771982540929;4255.255330317182;4304.7632380218765;4314.935275970863;4348.695591308578;4354.8911277217685;929.4934260827865;946.6071580294239;956.4404823178379;959.510649568725;960.6685693435753;522.9084910140787;612.7977767336769;621.552482212806;633.3160186998031;661.5369241530948;9583;9822;10196.439195844152;10212;10363.378197308186;545.6562365709577;599.5892813422819;620.314552419579;632.0613888375758;654.5679851298121;4491.164350073329;4763.142634325785;4816.638752093607;4818.734969576707;4823.659420110306;92325.07674923165;97705;98388.50805745926;98936.50531747295;99004;88022.3449274938;88325.67511487333;89987.55006225058;91011.08988910026;91863;76344.61827690827;76619;76944.84582731263;77047.22952770401;78544;9442.244620430212;9457.243420526203;9460.432374057578;9477.241820654193;9559;38472.6152738469;38601.227975440896;40067.599324007555;40662.10399492116;42006;67454.66272668606;68149;68479.3152068473;69343.65328173326;70024;10923;13519;13830.308484575933;14054.297285135906;14188.645283867985;13232.603021908973;14091.929540352232;14597.416103355747;14605.853941460875;15117.395304187708;13611.795823062464;13732.588022359345;13750.518731844337;13782.586522404345;13988.37052332668;13626.591202263948;13683.931580342034;13684.315784210949;13709;13825.585232443043;13316.800247996094;13476.9892258083;13480.5281815136;13579.388927498483;13801.624072136781;8828.558572071242;9835.114839664464;9909.900900990899;10088.766391379471;10677.57289708403;10385.948070259601;11065;11107.333559986426;11210.495527701436;11223.55105795759 10:21:27 INFO - PID 1646 | __end_tp_report 10:21:27 INFO - PID 1646 | __start_cc_report 10:21:27 INFO - PID 1646 | _x_x_mozilla_cycle_collect,1521 10:21:27 INFO - PID 1646 | __end_cc_report 10:21:27 INFO - PID 1646 | __startTimestamp1491412887143__endTimestamp 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | ------- Summary: start ------- 10:21:27 INFO - PID 1646 | Number of tests: 6 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | [#0] dojo.html Cycles:165 Average:6140.25 Median:6368.81 stddev:736.55 (11.6%) stddev-sans-first:693.64 10:21:27 INFO - PID 1646 | Values: 2902.8 3510.1 3516.8 3553.6 3582.6 6170.3 6224.5 6240.7 6274.0 6286.7 6154.8 6192.1 6215.9 6284.0 6284.9 4982.9 5309.3 5388.4 5408.5 5544.1 5452.0 5500.6 5506.1 5506.4 5518.5 5297.3 5350.7 5365.1 5373.5 5378.9 5363.5 5373.1 5393.7 5406.4 5413.4 5311.1 5353.9 5356.3 5369.3 5382.0 6134.3 6137.4 6137.6 6146.6 6149.3 6522.9 6551.9 6570.3 6620.4 6635.7 6717.7 6734.7 6736.3 6745.2 6751.3 6144.4 6317.7 6324.6 6335.4 6350.6 6673.9 6698.8 6779.2 6859.8 6891.5 6329.1 6414.1 6429.7 6450.6 6546.1 6687.2 6707.9 6713.6 6718.4 6727.3 6582.9 6599.1 6612.6 6614.3 6616.5 6352.6 6435.9 6438.2 6441.5 6609.6 5145.1 5309.4 5311.0 5311.4 5312.7 4660.8 4719.7 4760.5 4790.7 4824.3 6250.1 6344.3 6360.8 6367.5 6368.8 6695.3 6699.3 6715.5 6722.6 6725.6 6184.1 6273.9 6357.8 6370.9 6381.0 5836.9 5844.2 5847.7 5849.2 5868.8 6849.1 6854.1 6854.4 6870.8 6936.7 6684.2 6717.6 6725.7 6731.9 6733.9 6982.9 7006.1 7017.0 7025.5 7062.5 6302.0 6398.6 6439.6 6614.6 6616.5 6512.9 6583.6 6636.1 6646.8 6697.9 6471.2 6495.3 6496.2 6503.8 6506.5 6479.0 6480.4 6487.8 6494.9 6502.3 6280.3 6308.5 6333.4 6370.0 6376.1 6449.1 6470.4 6492.2 6499.4 6502.8 6319.7 6338.1 6342.5 6355.8 6381.4 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | [#1] ext.html Cycles:180 Average:55272.88 Median:36031.05 stddev:114257.97 (317.1%) stddev-sans-first:114505.16 10:21:27 INFO - PID 1646 | Values: 750.0 793.3 813.9 1142.3 1164.8 27533.4 37372.3 38115.0 38149.2 38214.4 35117.0 37671.6 39729.0 40082.6 40332.0 8495.7 8671.3 8677.9 8694.0 8715.7 6118.1 6275.9 8480.2 8682.3 8709.3 8639.0 8754.7 8768.0 8769.0 8774.6 8688.6 8714.5 8743.9 8749.6 8755.7 8413.9 8473.6 8479.5 8490.7 8505.5 37954.8 38178.0 38246.8 38308.4 38387.0 3422.4 3442.9 3446.7 3458.9 3464.9 30794.9 30803.7 30826.0 30871.7 30890.5 2956.9 3012.2 3100.8 3101.0 3119.6 262174.0 339357.0 346723.0 349355.0 350682.0 48764.8 48774.9 48979.0 49030.0 49079.8 50856.5 50874.0 50876.5 50898.0 51049.5 14100.3 14238.6 14242.4 14420.5 14482.5 11656.4 11680.5 11687.5 11697.2 11697.6 11648.5 11850.1 11854.5 11859.9 11895.4 5017.6 5609.4 5727.5 5735.3 5736.4 824.7 966.1 980.8 989.7 1019.2 22750.2 24140.8 24150.6 24158.5 24280.6 1068.7 1073.7 1118.1 1121.4 1134.7 10461.7 11449.4 11717.2 12406.8 12438.4 492620.0 496331.5 497287.0 497324.0 498592.0 55766.7 55891.4 56175.7 56187.7 56274.0 1454.6 1471.2 1515.9 1518.4 1530.1 23462.3 23550.1 23626.5 23631.0 23705.0 38981.0 39052.0 39105.8 39130.0 39232.0 441804.0 443161.8 443493.0 443823.0 444246.0 32060.0 32775.7 32798.8 32926.8 32940.0 42625.0 42650.9 42827.8 43491.8 43507.1 28828.4 29404.0 29523.7 29901.6 29992.0 29002.7 29595.0 30001.8 30177.4 30341.7 35688.6 36373.5 36442.6 36626.6 36689.6 30143.5 30338.0 30438.2 31159.5 31225.4 22515.9 24133.2 24139.8 24597.4 24717.0 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | [#2] jquery.html Cycles:180 Average:40755.59 Median:24245.20 stddev:116711.02 (481.4%) stddev-sans-first:116999.07 10:21:27 INFO - PID 1646 | Values: 389.7 430.5 434.7 443.4 460.6 18742.0 21482.6 21862.8 22611.4 23525.4 23240.9 23528.9 23899.5 24228.9 24261.5 4619.0 6225.0 6416.7 6423.8 6435.1 6265.2 6266.0 6373.3 6375.1 6381.8 5691.6 6246.0 6263.4 6275.9 6296.9 6121.9 6221.7 6246.5 6280.6 6350.4 5611.2 5616.3 5621.9 5622.0 5627.7 27807.7 28032.7 28130.0 28192.0 28420.7 2081.3 2170.5 2175.8 2216.2 2244.8 15572.8 17229.9 17948.9 18297.5 18598.2 2115.4 2126.5 2131.3 2158.6 2163.9 139467.3 167046.0 168706.2 168822.0 169528.0 9084.7 10628.3 12704.3 12768.4 12855.9 15680.1 17134.1 17139.8 17166.1 17178.6 7260.7 8723.2 8874.5 9006.2 9129.5 8434.3 8437.0 8446.8 8604.5 8616.7 7949.3 8059.3 8161.5 8172.3 8177.7 1854.2 2106.1 2112.4 2113.4 2271.1 891.6 907.4 909.6 949.2 955.6 20559.9 21490.7 21506.2 21511.7 21550.5 884.7 964.6 965.8 967.6 994.2 9190.6 11034.4 11085.4 11109.0 11112.7 621032.0 701301.0 703590.0 716617.0 721804.0 154815.0 156733.1 158832.0 161153.2 161849.0 1016.8 1166.6 1171.0 1233.9 1238.7 19931.8 21051.4 22990.9 23090.0 23750.6 57132.7 57948.7 59282.7 59835.1 59854.7 59869.0 79501.2 79689.6 79775.0 80565.6 8702.8 8741.3 8813.1 9291.0 9305.8 11912.9 12614.2 14420.6 14680.7 14943.4 11929.8 12090.9 12173.5 12310.0 12313.1 9715.9 11467.3 11515.7 11716.1 11753.9 11564.7 11580.4 11846.6 12252.1 12322.5 8688.9 9089.8 9108.6 9252.4 9328.2 11587.5 11715.6 12032.8 12079.8 12127.8 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | [#3] mootools.html Cycles:180 Average:6984.48 Median:3840.06 stddev:4443.37 (115.7%) stddev-sans-first:4435.50 10:21:27 INFO - PID 1646 | Values: 1327.5 1414.9 1430.1 1432.5 1436.0 11229.0 11751.5 11766.8 11772.4 11813.0 10783.2 11466.5 11880.3 11905.9 11923.3 2075.8 2557.5 2561.3 2562.2 2563.1 2466.2 2483.4 2533.5 2539.1 2541.0 2435.2 2540.0 2541.3 2543.2 2545.2 2465.3 2506.1 2517.6 2548.4 2549.7 2491.8 2512.8 2521.5 2522.4 2525.0 11481.9 11696.8 11731.9 11745.9 11751.7 6494.4 6746.9 6747.0 6758.5 6785.5 4038.7 4218.2 4307.9 4322.2 4382.7 1168.1 1193.9 1204.8 1252.7 1286.3 14840.9 15295.9 15330.2 15941.0 16067.5 5380.9 5464.6 5665.5 5672.8 5697.6 12030.3 12054.9 12075.3 12084.9 12087.6 5709.9 5984.0 6592.7 6612.7 6615.4 5129.8 5327.4 5427.8 5490.6 6221.8 3664.3 4242.3 4299.0 4342.3 4406.0 1270.1 1274.8 1275.2 1297.0 1299.4 673.7 760.9 768.9 770.1 770.7 5886.8 5940.0 6111.0 6137.8 6154.0 489.3 563.5 589.9 606.4 607.0 3767.8 3912.4 4197.9 4204.4 4226.2 14338.6 14951.9 15016.8 15035.1 15046.8 14870.3 14917.6 14919.6 14921.6 14931.2 8665.5 9372.8 10225.3 10837.0 10866.3 5395.7 6221.8 6796.9 6946.5 7002.1 10781.2 12614.5 12911.5 12930.6 13004.4 13767.3 13865.3 14008.0 14095.3 14221.4 8439.8 8445.9 8449.6 8555.7 8559.9 9770.4 9989.1 9989.8 9994.5 10030.5 8758.3 8964.4 8973.9 9056.2 9155.2 7232.8 8783.3 8806.8 8825.7 8951.8 7531.0 7925.6 7928.5 7933.4 7938.2 5764.7 5837.2 5972.2 6047.1 6078.2 5905.9 5989.0 6074.3 6159.4 6300.2 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | [#4] prototype.html Cycles:180 Average:4945.59 Median:5443.30 stddev:1548.71 (28.5%) stddev-sans-first:1513.90 10:21:27 INFO - PID 1646 | Values: 334.7 360.4 391.4 404.3 405.8 4843.6 5916.4 5935.9 5936.0 5938.3 5195.9 5799.4 5804.8 5840.9 5845.0 4382.7 4418.7 4463.8 4477.5 4482.8 3677.5 4463.4 4475.2 4487.8 4507.8 3641.7 4148.8 4434.5 4448.2 4471.5 3512.7 3566.8 4211.0 4285.3 4293.4 3732.5 3734.4 3737.3 3745.4 3749.6 4654.8 5675.9 5697.7 5724.9 5739.3 4838.6 4996.6 5083.8 5094.4 5106.2 6160.8 6182.8 6188.2 6193.3 6203.6 3695.7 4043.4 4217.7 4218.7 4221.9 4691.5 6046.5 6196.4 6377.2 6388.7 3905.7 4145.8 4219.2 4226.6 4228.9 3944.7 4160.9 4287.9 4292.6 4303.3 3981.2 4018.9 4430.4 5015.6 5039.5 5408.7 6219.6 6250.6 6256.7 6260.0 1236.4 1463.7 1482.6 1486.3 1489.0 934.8 980.1 990.1 990.8 1007.6 4905.2 5427.5 5893.5 5907.6 5927.8 6425.9 6449.8 6464.7 6473.4 6486.9 4884.2 4980.5 5209.5 5404.8 5853.4 3306.9 3330.9 3331.5 3336.3 3357.7 6430.4 6456.6 6626.3 6628.1 6716.8 5571.0 5649.0 5751.4 6460.8 6615.2 6366.6 6369.7 6625.7 6648.4 6663.5 5125.8 5672.3 6005.3 6360.0 6372.9 5177.3 5459.1 6319.8 6324.2 6334.0 5405.3 5459.3 6456.8 6671.1 6744.0 3516.9 4257.9 4263.5 4269.3 4281.6 5273.2 6475.9 6489.4 6502.6 6505.8 5875.9 6096.0 6119.8 6207.2 6207.3 4819.7 5500.3 6232.7 6235.9 6244.3 5292.8 5512.4 6045.9 6101.2 6114.9 4714.8 5232.1 6041.7 6165.2 6233.9 5400.3 6037.9 6088.6 6099.5 6124.5 10:21:27 INFO - PID 1646 | 10:21:27 INFO - PID 1646 | [#5] yui.html Cycles:180 Average:20453.76 Median:3423.89 stddev:29099.21 (849.9%) stddev-sans-first:29143.18 10:21:27 INFO - PID 1646 | Values: 737.3 806.6 828.7 836.6 842.1 16051.4 16412.8 16424.3 16451.2 16460.8 14634.0 15066.9 15242.2 15579.8 15740.1 775.3 974.1 989.1 992.9 994.2 1006.6 1017.4 1019.6 1020.6 1023.6 1065.6 1066.4 1067.2 1068.1 1069.7 1062.3 1065.9 1065.9 1067.3 1068.2 780.2 784.1 784.1 784.4 785.7 16025.8 16180.6 16282.5 17174.7 17239.3 11614.4 14803.4 14812.9 14853.5 14901.8 12341.6 12801.3 13380.7 13394.9 13515.1 3406.9 3440.9 3442.8 3444.5 3453.4 108899.5 109141.0 110902.3 110944.0 111837.0 11456.2 11466.3 11492.7 11496.9 11552.9 24351.1 24715.6 24921.8 25136.6 25193.0 7718.4 7727.9 7782.4 7896.7 7935.6 4060.2 4083.6 4089.7 4111.1 4145.8 4255.3 4304.8 4314.9 4348.7 4354.9 929.5 946.6 956.4 959.5 960.7 522.9 612.8 621.6 633.3 661.5 9583.0 9822.0 10196.4 10212.0 10363.4 545.7 599.6 620.3 632.1 654.6 4491.2 4763.1 4816.6 4818.7 4823.7 92325.1 97705.0 98388.5 98936.5 99004.0 88022.3 88325.7 89987.6 91011.1 91863.0 76344.6 76619.0 76944.8 77047.2 78544.0 9442.2 9457.2 9460.4 9477.2 9559.0 38472.6 38601.2 40067.6 40662.1 42006.0 67454.7 68149.0 68479.3 69343.7 70024.0 10923.0 13519.0 13830.3 14054.3 14188.6 13232.6 14091.9 14597.4 14605.9 15117.4 13611.8 13732.6 13750.5 13782.6 13988.4 13626.6 13683.9 13684.3 13709.0 13825.6 13316.8 13477.0 13480.5 13579.4 13801.6 8828.6 9835.1 9909.9 10088.8 10677.6 10385.9 11065.0 11107.3 11210.5 11223.6 10:21:27 INFO - PID 1646 | -------- Summary: end -------- 10:21:27 INFO - PID 1646 | 10:21:27 INFO - TEST-INFO | 1646: exit 0 10:21:27 INFO - TEST-OK | dromaeo_css | took 1121762ms 10:21:27 INFO - TEST-START | kraken 10:21:27 INFO - operating with platform_type : mac_ 10:21:27 INFO - Initialising browser for kraken test... 10:21:27 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmp0o0QQ9/profile http://localhost:49248/getInfo.html) 10:21:30 INFO - PID 1656 | __metrics Screen width/height:1600/1200 10:21:30 INFO - PID 1656 | colorDepth:24 10:21:30 INFO - PID 1656 | Browser inner width/height: 1024/689 10:21:30 INFO - PID 1656 | __metrics 10:21:30 INFO - PID 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:21:30 INFO - PID 1656 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:31 INFO - TEST-INFO | 1656: exit 0 10:21:31 INFO - Browser initialized. 10:21:31 INFO - Running cycle 1/1 for kraken test... 10:21:31 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmp0o0QQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:44 INFO - PID 1657 | RSS: Main: 238338048 10:21:44 INFO - PID 1657 | 10:21:47 INFO - PID 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) 10:21:48 INFO - PID 1657 | RSS: Main: 291876864 10:21:48 INFO - PID 1657 | 10:21:50 INFO - PID 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) 10:21:51 INFO - PID 1657 | RSS: Main: 292360192 10:21:51 INFO - PID 1657 | 10:21:55 INFO - PID 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) 10:21:55 INFO - PID 1657 | RSS: Main: 387911680 10:21:55 INFO - PID 1657 | 10:21:57 INFO - PID 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) 10:21:58 INFO - PID 1657 | RSS: Main: 288235520 10:21:58 INFO - PID 1657 | 10:22:00 INFO - PID 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) 10:22:01 INFO - PID 1657 | RSS: Main: 291442688 10:22:01 INFO - PID 1657 | 10:22:04 INFO - PID 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) 10:22:05 INFO - PID 1657 | RSS: Main: 333398016 10:22:05 INFO - PID 1657 | 10:22:08 INFO - PID 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) 10:22:09 INFO - PID 1657 | RSS: Main: 342278144 10:22:09 INFO - PID 1657 | 10:22:12 INFO - PID 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) 10:22:13 INFO - PID 1657 | RSS: Main: 345518080 10:22:13 INFO - PID 1657 | 10:22:14 INFO - PID 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) 10:22:15 INFO - PID 1657 | RSS: Main: 310124544 10:22:15 INFO - PID 1657 | 10:22:17 INFO - PID 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) 10:22:17 INFO - PID 1657 | RSS: Main: 315154432 10:22:17 INFO - PID 1657 | 10:22:20 INFO - PID 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) 10:22:20 INFO - PID 1657 | RSS: Main: 316690432 10:22:20 INFO - PID 1657 | 10:22:24 INFO - PID 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) 10:22:24 INFO - PID 1657 | RSS: Main: 332275712 10:22:24 INFO - PID 1657 | 10:22:28 INFO - PID 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) 10:22:28 INFO - PID 1657 | RSS: Main: 315400192 10:22:28 INFO - PID 1657 | 10:22:30 INFO - PID 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) 10:22:30 INFO - PID 1657 | RSS: Main: 381554688 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | __start_tp_report 10:22:30 INFO - PID 1657 | _x_x_mozilla_page_load 10:22:30 INFO - PID 1657 | _x_x_mozilla_page_load_details 10:22:30 INFO - PID 1657 | |i|pagename|runs| 10:22:30 INFO - PID 1657 | |0;ai-astar;110;121;120;123;124;122;122;124;121;121 10:22:30 INFO - PID 1657 | |1;audio-beat-detection;161;120;116;159;122;120;120;118;144;119 10:22:30 INFO - PID 1657 | |2;audio-dft;212;214;219;217;211;210;207;213;215;210 10:22:30 INFO - PID 1657 | |3;audio-fft;85;71;91;131;83;63;65;59;85;66 10:22:30 INFO - PID 1657 | |4;audio-oscillator;94;76;101;101;112;102;94;78;112;128 10:22:30 INFO - PID 1657 | |5;imaging-gaussian-blur;93;91;93;92;91;91;92;91;92;91 10:22:30 INFO - PID 1657 | |6;imaging-darkroom;103;101;101;126;155;136;99;101;101;131 10:22:30 INFO - PID 1657 | |7;imaging-desaturate;101;101;101;133;162;127;98;100;101;102 10:22:30 INFO - PID 1657 | |8;json-parse-financial;53;52;51;51;51;53;52;52;52;52 10:22:30 INFO - PID 1657 | |9;json-stringify-tinderbox;55;67;87;68;65;64;61;64;62;64 10:22:30 INFO - PID 1657 | |10;stanford-crypto-aes;81;95;111;119;117;88;94;91;92;90 10:22:30 INFO - PID 1657 | |11;stanford-crypto-ccm;153;151;148;155;145;151;148;154;208;195 10:22:30 INFO - PID 1657 | |12;stanford-crypto-pbkdf2;201;215;225;212;198;202;209;201;204;205 10:22:30 INFO - PID 1657 | |13;stanford-crypto-sha256-iterative;73;77;74;74;72;73;72;75;73;72 10:22:30 INFO - PID 1657 | __end_tp_report 10:22:30 INFO - PID 1657 | __start_cc_report 10:22:30 INFO - PID 1657 | _x_x_mozilla_cycle_collect,2149 10:22:30 INFO - PID 1657 | __end_cc_report 10:22:30 INFO - PID 1657 | __startTimestamp1491412950914__endTimestamp 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | ------- Summary: start ------- 10:22:30 INFO - PID 1657 | Number of tests: 14 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#0] ai-astar Cycles:10 Average:120.80 Median:122.00 stddev:4.02 (3.3%) stddev-sans-first:1.41 10:22:30 INFO - PID 1657 | Values: 110.0 121.0 120.0 123.0 124.0 122.0 122.0 124.0 121.0 121.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:121.00 stddev:17.71 (14.6%) stddev-sans-first:14.78 10:22:30 INFO - PID 1657 | Values: 161.0 120.0 116.0 159.0 122.0 120.0 120.0 118.0 144.0 119.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#2] audio-dft Cycles:10 Average:212.80 Median:213.50 stddev:3.58 (1.7%) stddev-sans-first:3.79 10:22:30 INFO - PID 1657 | Values: 212.0 214.0 219.0 217.0 211.0 210.0 207.0 213.0 215.0 210.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#3] audio-fft Cycles:10 Average:79.90 Median:77.00 stddev:21.12 (27.4%) stddev-sans-first:22.32 10:22:30 INFO - PID 1657 | Values: 85.0 71.0 91.0 131.0 83.0 63.0 65.0 59.0 85.0 66.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:102.00 stddev:15.67 (15.4%) stddev-sans-first:16.48 10:22:30 INFO - PID 1657 | Values: 94.0 76.0 101.0 101.0 112.0 102.0 94.0 78.0 112.0 128.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:92.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 10:22:30 INFO - PID 1657 | Values: 93.0 91.0 93.0 92.0 91.0 91.0 92.0 91.0 92.0 91.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#6] imaging-darkroom Cycles:10 Average:115.40 Median:128.50 stddev:20.00 (15.6%) stddev-sans-first:20.70 10:22:30 INFO - PID 1657 | Values: 103.0 101.0 101.0 126.0 155.0 136.0 99.0 101.0 101.0 131.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:114.50 stddev:21.31 (18.6%) stddev-sans-first:22.18 10:22:30 INFO - PID 1657 | Values: 101.0 101.0 101.0 133.0 162.0 127.0 98.0 100.0 101.0 102.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 10:22:30 INFO - PID 1657 | Values: 53.0 52.0 51.0 51.0 51.0 53.0 52.0 52.0 52.0 52.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:64.50 stddev:8.30 (12.9%) stddev-sans-first:7.85 10:22:30 INFO - PID 1657 | Values: 55.0 67.0 87.0 68.0 65.0 64.0 61.0 64.0 62.0 64.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:90.50 stddev:13.05 (14.4%) stddev-sans-first:12.35 10:22:30 INFO - PID 1657 | Values: 81.0 95.0 111.0 119.0 117.0 88.0 94.0 91.0 92.0 90.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:153.50 stddev:21.88 (14.3%) stddev-sans-first:23.02 10:22:30 INFO - PID 1657 | Values: 153.0 151.0 148.0 155.0 145.0 151.0 148.0 154.0 208.0 195.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.20 Median:207.00 stddev:8.22 (4.0%) stddev-sans-first:8.40 10:22:30 INFO - PID 1657 | Values: 201.0 215.0 225.0 212.0 198.0 202.0 209.0 201.0 204.0 205.0 10:22:30 INFO - PID 1657 | 10:22:30 INFO - PID 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.50 stddev:1.58 (2.2%) stddev-sans-first:1.67 10:22:30 INFO - PID 1657 | Values: 73.0 77.0 74.0 74.0 72.0 73.0 72.0 75.0 73.0 72.0 10:22:30 INFO - PID 1657 | -------- Summary: end -------- 10:22:30 INFO - PID 1657 | 10:22:32 INFO - TEST-INFO | 1657: exit 0 10:22:32 INFO - TEST-OK | kraken | took 64269ms 10:22:32 INFO - SUITE-END | took 1186s 10:22:32 INFO - Completed test suite (00:19:46) 10:22:32 INFO - javascript benchmark 10:22:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7709.758974922926, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2902.8113172643775, 3510.140015696155, 3516.8241587920597, 3553.6091029986696, 3582.6238244984274, 6170.290416602092, 6224.533160013, 6240.719167637456, 6273.964795808692, 6286.654234017127, 6154.753809847612, 6192.071189321604, 6215.937840621593, 6283.968580157093, 6284.937150628492, 4982.9252561211615, 5309.283246761676, 5388.380336261341, 5408.540274076709, 5544.0575102232715, 5452.04589196889, 5500.6424582402215, 5506.149479659425, 5506.449355064502, 5518.530924871371, 5297.311349524575, 5350.705711185883, 5365.061114304981, 5373.543248823855, 5378.946210537883, 5363.517283444469, 5373.086575282172, 5393.7303134843105, 5406.405295417501, 5413.377461591888, 5311.123664595337, 5353.919691204596, 5356.303680521507, 5369.301990741218, 5381.973090134525, 6134.2529056856065, 6137.358988059849, 6137.570370074097, 6146.647737497743, 6149.323574406856, 6522.869542609121, 6551.93448065518, 6570.310117437648, 6620.437262832616, 6635.6682165892, 6717.664116794141, 6734.696938637773, 6736.292689267654, 6745.156855393076, 6751.25736169021, 6144.354842741537, 6317.684115794238, 6324.588901721373, 6335.3981371769605, 6350.618962862243, 6673.933260667428, 6698.83252918681, 6779.15260592426, 6859.794206173823, 6891.517593768488, 6329.113924050636, 6414.102025716404, 6429.710663020175, 6450.580712253689, 6546.0508226307875, 6687.164104486939, 6707.899381509281, 6713.597184168965, 6718.428933540606, 6727.327267273234, 6582.901256481156, 6599.1091202687985, 6612.570182938093, 6614.338566143347, 6616.470682345497, 6352.555321127569, 6435.903461448082, 6438.195225596801, 6441.549091563639, 6609.636469994197, 5145.099607568661, 5309.41596424393, 5311.0, 5311.389190243094, 5312.654677445954, 4660.813567457331, 4719.716816990992, 4760.476347601761, 4790.688605240648, 4824.300476430968, 6250.062490626351, 6344.333844946306, 6360.809175724736, 6367.52243581724, 6368.808935731843, 6695.296993815579, 6699.330066993261, 6715.496337774686, 6722.563033402911, 6725.596464212163, 6184.134221209034, 6273.905891411632, 6357.841053973688, 6370.872582548323, 6381.0, 5836.88326233473, 5844.211031510692, 5847.6783776891825, 5849.151872978395, 5868.765249390062, 6849.1096157499205, 6854.143232095988, 6854.417374523022, 6870.793876183722, 6936.7225310987, 6684.197896252481, 6717.630530320879, 6725.697343619647, 6731.932680673131, 6733.865322693421, 6982.8840137882935, 7006.124234470692, 7017.0, 7025.543339682904, 7062.4703147263135, 6301.991681330965, 6398.616083035033, 6439.613623182624, 6614.636195009129, 6616.503762217757, 6512.902306465312, 6583.604983700993, 6636.070950067091, 6646.767363142267, 6697.899531506934, 6471.191101112361, 6495.317991610813, 6496.220453545605, 6503.804885853432, 6506.544541882023, 6478.967605161944, 6480.351964803482, 6487.837804054936, 6494.935050649433, 6502.252240992347, 6280.277768056732, 6308.463780578702, 6333.36666333363, 6370.044493326038, 6376.075469056868, 6449.097126402214, 6470.417662410406, 6492.188476440445, 6499.415052645285, 6502.837429064311, 6319.652419116993, 6338.144350512622, 6342.460890824147, 6355.7775477859905, 6381.361863813767], "value": 6087.682028218489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.9662515186816, 793.2900054451267, 813.9348852091833, 1142.2917790969595, 1164.7961606718823, 27533.44933101339, 37372.252554948886, 38114.99999999996, 38149.23701525968, 38214.42678359827, 35117.0, 37671.623283767156, 39729.0, 40082.59917400825, 40332.0, 8495.660173593064, 8671.349648776335, 8677.913220867806, 8694.0, 8715.694950676727, 6118.143459915593, 6275.874482510347, 8480.151984801501, 8682.348823838205, 8709.34679899007, 8639.006514250847, 8754.6935857245, 8767.956160219223, 8769.035406105324, 8774.605142768558, 8688.56557172142, 8714.520701361422, 8743.868841967344, 8749.606267717969, 8755.693550725759, 8413.873791893126, 8473.576321183917, 8479.491230526126, 8490.66037358505, 8505.489670619783, 37954.81022594897, 38178.0, 38246.80876595627, 38308.42537361914, 38387.0, 3422.401079811023, 3442.915481623306, 3446.724262059029, 3458.9308213835584, 3464.9133771655656, 30794.92217772367, 30803.691963080306, 30826.0, 30871.691283087108, 30890.536641950388, 2956.8669409876393, 3012.2469382654335, 3100.829454380008, 3100.9766776963547, 3119.5788568543185, 262174.0, 339357.0, 346723.0, 349355.0, 350682.0, 48764.75617621889, 48774.90313710786, 48979.0, 49030.0, 49079.754601227476, 50856.49143508592, 50873.982520350124, 50876.49123508792, 50898.0, 51049.46851594458, 14100.294985250697, 14238.572842814732, 14242.43030278798, 14420.495282665057, 14482.493112741004, 11656.358900260568, 11680.474378652982, 11687.532498699957, 11697.23967942081, 11697.649070527897, 11648.475818588184, 11850.11124165691, 11854.525818967317, 11859.940700296444, 11895.405229738479, 5017.598592112622, 5609.354924183689, 5727.4845263926445, 5735.311762588432, 5736.42635736423, 824.6989848705299, 966.1497881863914, 980.8087422952599, 989.7278248481725, 1019.2253887045898, 22750.203742868922, 24140.758592414204, 24150.637740433907, 24158.51682966331, 24280.63579046316, 1068.7435015596357, 1073.7423018475665, 1118.139032944628, 1121.4448847820381, 1134.7219931116929, 10461.74459064917, 11449.427528623535, 11717.179797414099, 12406.81389779154, 12438.378081095909, 492620.0, 496331.51834240597, 497287.0, 497324.0, 498592.028159442, 55766.72116639391, 55891.44108558944, 56175.719121404945, 56187.71906140525, 56274.0, 1454.614527150306, 1471.1687896338321, 1515.9085458469883, 1518.3622878391102, 1530.1278271385427, 23462.296131116094, 23550.114231151667, 23626.52746945017, 23631.0, 23705.0, 38981.0, 39052.0, 39105.80447097746, 39130.0, 39232.0, 441804.0, 443161.784191077, 443493.0, 443823.0, 444246.0, 32060.0, 32775.67224327726, 32798.836005819816, 32926.83536582302, 32940.0, 42625.0, 42650.93372665708, 42827.78586107049, 43491.78254108836, 43507.129857403306, 28828.42343153167, 29404.0, 29523.704762952097, 29901.551476728302, 29991.950281740035, 29002.7099729, 29595.0, 30001.849990749906, 30177.396452071276, 30341.69658303389, 35688.64311356957, 36373.45439818458, 36442.63557364392, 36626.633733662326, 36689.63310366969, 30143.547846782756, 30338.0, 30438.239044024078, 31159.53260701046, 31225.37549249048, 22515.874206289947, 24133.155339563033, 24139.758602414455, 24597.38506537351, 24717.0], "value": 17801.088904312564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7310855509696, 430.4804041732685, 434.6848534812261, 443.37705523739146, 460.606181714634, 18742.0, 21482.570348593017, 21862.797546134956, 22611.434714132156, 23525.41186470339, 23240.883795580998, 23528.88235558824, 23899.522009559798, 24228.878855605697, 24261.514769704638, 4619.030003699228, 6224.96887515563, 6416.679166041703, 6423.80728578141, 6435.066915297279, 6265.154204182422, 6265.9686701566425, 6373.298937116913, 6375.139356186925, 6381.7766378176775, 5691.630044047144, 6246.0, 6263.436290733833, 6275.937240627603, 6296.859067916907, 6121.908171377433, 6221.657808820513, 6246.531510136735, 6280.591761535508, 6350.396712312346, 5611.186377975171, 5616.269884914935, 5621.943780562183, 5622.0, 5627.71861406928, 27807.721922780715, 28032.719672803214, 28130.015449459377, 28192.0, 28420.715792842013, 2081.261152290945, 2170.5007848195005, 2175.8368122390884, 2216.213244298283, 2244.7867452591977, 15572.766408503881, 17229.913850430792, 17948.923064616036, 18297.542561436072, 18598.16308266131, 2115.375964090597, 2126.5008169240805, 2131.296672098204, 2158.557495713375, 2163.945901352463, 139467.30266348706, 167046.0, 168706.15646921686, 168822.0, 169528.0, 9084.682036128705, 10628.25602207838, 12704.301263430416, 12768.425420856083, 12855.871441285468, 15680.137592432526, 17134.14329283531, 17139.828601713823, 17166.05586692744, 17178.570535736457, 7260.709571617076, 8723.171298726611, 8874.511901845332, 9006.234470070118, 9129.45223286605, 8434.28308593764, 8437.0, 8446.788830279293, 8604.48373097616, 8616.698415555426, 7949.284564389232, 8059.274665280153, 8161.469504482189, 8172.264496195371, 8177.67289308421, 1854.1736389656178, 2106.147010460735, 2112.376848829599, 2113.3765539165984, 2271.0575111328612, 891.6076926152472, 907.419251678926, 909.6088681866728, 949.231122790528, 955.603424578792, 20559.897200514202, 21490.677639835416, 21506.247281345077, 21511.67732484014, 21550.461238469165, 884.6638277454526, 964.6189755046857, 965.82615129276, 967.6018153767878, 994.1599348550463, 9190.632374704937, 11034.393108378956, 11085.390303533382, 11109.0, 11112.666620001413, 621032.0, 701301.0, 703590.0, 716617.0, 721804.0, 154815.0, 156733.0816729591, 158832.0, 161153.19423402808, 161849.0, 1016.8220561401578, 1166.597523854269, 1171.0088691795947, 1233.858106317767, 1238.659368673604, 19931.800681992994, 21051.368458946257, 22990.93081622662, 23090.0, 23750.643740344254, 57132.714336429715, 57948.710256448445, 59282.70358648179, 59835.10247346206, 59854.70072649609, 59869.0, 79501.2049879517, 79689.60155199187, 79775.0, 80565.59717201376, 8702.782430439289, 8741.300695944436, 8813.118688131135, 9291.024442433447, 9305.813883722423, 11912.940435297767, 12614.243145411305, 14420.639484012983, 14680.706385872436, 14943.402263909322, 11929.82105268439, 12090.939545302217, 12173.513059477877, 12310.015198783896, 12313.076519260912, 9715.9028409715, 11467.31196128235, 11515.712107197052, 11716.121290903387, 11753.941230293794, 11564.710882228012, 11580.378746975599, 11846.644600661994, 12252.142350035412, 12322.50709971627, 8688.91311086881, 9089.772880661027, 9108.635654574007, 9252.398594091363, 9328.160465558132, 11587.478563464832, 11715.589954351557, 12032.819507707567, 12079.75840483203, 12127.81808272859], "value": 10637.565000185808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.5088217359576, 1414.8868090552758, 1430.1276221504884, 1432.5415866922583, 1436.037854637393, 11229.0, 11751.529938802449, 11766.823497647541, 11772.352520611374, 11812.995895348906, 10783.191260655463, 11466.48400821963, 11880.28718276904, 11905.92846643802, 11923.344216068113, 2075.802798734125, 2557.5012872489874, 2561.346856551586, 2562.167295628928, 2563.102913980101, 2466.1984854922134, 2483.4412257242157, 2533.518631460017, 2539.098619989905, 2541.0471073347494, 2435.2450740270483, 2539.987300063506, 2541.3392517945376, 2543.1988923489043, 2545.2491515003117, 2465.3466831289725, 2506.135383292761, 2517.5845985412475, 2548.4266040141006, 2549.6685430893867, 2491.813114016456, 2512.8115391345723, 2521.470491196851, 2522.369407648088, 2525.02786427225, 11481.942590287079, 11696.766064678744, 11731.88268117325, 11745.941270293593, 11751.7062073448, 6494.350564943515, 6746.93253067468, 6746.966265168692, 6758.459323254128, 6785.457163426914, 4038.6720528544015, 4218.1985422769885, 4307.892302692458, 4322.243607368698, 4382.671299652538, 1168.0713832503181, 1193.934333611651, 1204.777116233491, 1252.6868282929267, 1286.2668279080929, 14840.851591484055, 15295.923520382326, 15330.15684137372, 15941.0, 16067.517974460668, 5380.865478363072, 5464.617476776667, 5665.461781130868, 5672.801451949162, 5697.629654072555, 12030.27818330903, 12054.939725301492, 12075.3358565278, 12084.879151208552, 12087.637370878712, 5709.914351284734, 5984.042553191469, 6592.703328350236, 6612.7354905804195, 6615.437687796495, 5129.8201413674315, 5327.360716713942, 5427.755750991215, 5490.615656903979, 6221.782237621662, 3664.2854643344826, 4242.257604919127, 4299.011227417712, 4342.305231162999, 4405.9559404405545, 1270.1172684984033, 1274.8278982337265, 1275.1647670775658, 1296.9805452918213, 1299.4471606430225, 673.6526946107784, 760.8744557148009, 768.8885111658778, 770.1451388958252, 770.7495064104188, 5886.793962211388, 5940.049592065248, 6110.969445152746, 6137.815865524041, 6153.969230153821, 489.307629703972, 563.5097465205216, 589.8613825750945, 606.4269265544018, 607.0439058482907, 3767.7550959188115, 3912.374020156818, 4197.929527970348, 4204.4324016257415, 4226.1758957003085, 14338.56984290473, 14951.87860910436, 15016.849831501764, 15035.097894126387, 15046.849531504764, 14870.256487175815, 14917.552473425814, 14919.568499245017, 14921.626959325886, 14931.17878516692, 8665.523396213142, 9372.812543749087, 10225.335353202017, 10837.024667779937, 10866.293690910225, 5395.70323632204, 6221.813345599639, 6796.864062718817, 6946.548474349152, 7002.054722612382, 10781.24531282834, 12614.49542018309, 12911.483540658268, 12930.612081637566, 13004.414801334153, 13767.311634418038, 13865.306734663025, 14008.019438639198, 14095.295235237993, 14221.360038798071, 8439.789005274917, 8445.873311900203, 8449.577521124042, 8555.700550480704, 8559.871601926101, 9770.413775173512, 9989.100980911753, 9989.750256243651, 9994.500274986367, 10030.498475076363, 8758.255548278214, 8964.417312874642, 8973.865392018994, 9056.184943355129, 9155.176034156957, 7232.770429026973, 8783.341249406449, 8806.823863522823, 8825.69110081144, 8951.776205594912, 7530.966639007547, 7925.564093974886, 7928.484648497829, 7933.404994625311, 7938.206179382016, 5764.682942438206, 5837.241158649348, 5972.223610930551, 6047.123167140828, 6078.209832721718, 5905.852353691193, 5989.0, 6074.331823499323, 6159.384061593984, 6300.180976473029], "value": 5227.642632150891, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.7205083755064, 360.4143267190815, 391.37184818366524, 404.31670476894067, 405.7524909805018, 4843.5882949949255, 5916.437938395851, 5935.851603709904, 5936.0, 5938.317093534245, 5195.870103247421, 5799.391063938289, 5804.82585522435, 5840.941590584093, 5845.0, 4382.693211475198, 4418.668599855007, 4463.821447142111, 4477.48508921475, 4482.775861206943, 3677.52192215013, 4463.375127482155, 4475.216837053519, 4487.775611219442, 4507.752073635948, 3641.6904563112034, 4148.81758698771, 4434.512203657595, 4448.221561226788, 4471.53048929861, 3512.701420379271, 3566.769464534744, 4211.031462763566, 4285.314349704064, 4293.4203882476095, 3732.496113024734, 3734.421164719473, 3737.289914916157, 3745.382011968022, 3749.643783840531, 4654.813807447698, 5675.886482270332, 5697.715114244271, 5724.8855022899725, 5739.282589676291, 4838.620993017009, 4996.600271978269, 5083.822066227664, 5094.439611642716, 5106.183010718267, 6160.84597885052, 6182.783602573888, 6188.226471691039, 6193.3496982816605, 6203.565750397474, 3695.722820788452, 4043.433919251307, 4217.746935183868, 4218.6835987300765, 4221.87334379966, 4691.5308469152815, 6046.455818976269, 6196.380361963767, 6377.202849643794, 6388.7125079371535, 3905.6680182184264, 4145.834166633361, 4219.177260434186, 4226.640735537452, 4228.936565951513, 3944.7041471889725, 4160.918161278089, 4287.871363859027, 4292.570742925683, 4303.289957157097, 3981.203759248162, 4018.9397159042637, 4430.379746835446, 5015.623828212899, 5039.546440820343, 5408.702521361363, 6219.626822390671, 6250.593711408835, 6256.749730010749, 6259.968700156561, 1236.3694515796828, 1463.6999415119874, 1482.629342664334, 1486.3385793321868, 1488.9949284233098, 934.8335185511968, 980.0836218136066, 990.1187942730975, 990.8414653655525, 1007.6322142417964, 4905.23968784839, 5427.453175844866, 5893.528517718572, 5907.556933230025, 5927.762889484372, 6425.903361764211, 6449.838754031093, 6464.709088091047, 6473.449756770728, 6486.870262594722, 4884.242942343943, 4980.452150263468, 5209.453007434241, 5404.8113810742125, 5853.385394533598, 3306.93386132276, 3330.900072997814, 3331.53358529806, 3336.299377130781, 3357.6642335766714, 6430.356964303533, 6456.630904521344, 6626.337366263431, 6628.072069910217, 6716.832079197961, 5570.97214513933, 5648.9717551412805, 5751.447109280471, 6460.806175814639, 6615.239247486601, 6366.6180029198395, 6369.681515924185, 6625.701843417058, 6648.434883034996, 6663.5002374821115, 5125.8466844959585, 5672.298310506749, 6005.339412664691, 6360.0, 6372.87254254903, 5177.275181474522, 5459.143891077053, 6319.778807741707, 6324.209473815773, 6334.0, 5405.324334458192, 5459.2902922619805, 6456.806295811133, 6671.099401580918, 6744.0, 3516.8593256270487, 4257.893552661209, 4263.467066616673, 4269.295566231661, 4281.614654681093, 5273.235380869829, 6475.935240647722, 6489.415952564292, 6502.642354670538, 6505.78803206893, 5875.853103672443, 6096.0, 6119.84700382494, 6207.224096987877, 6207.299824576143, 4819.662623616454, 5500.339959204921, 6232.657203853832, 6235.937640623717, 6244.313125556276, 5292.788288468572, 5512.448755124456, 6045.879082418239, 6101.237345331833, 6114.877702446015, 4714.81140754366, 5232.148479078987, 6041.728122234598, 6165.181271524822, 6233.906491402542, 5400.269767350262, 6037.882991646559, 6088.573799833969, 6099.4815440688035, 6124.510039196943], "value": 4471.837905795524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3400806278381, 806.5926707012958, 828.6768160417442, 836.6402446947814, 842.0695131879271, 16051.357945682174, 16412.753808692865, 16424.343026278933, 16451.177441127955, 16460.75308870365, 14634.04878682885, 15066.945313828037, 15242.237888105577, 15579.84420155798, 15740.134292613902, 775.3448336155939, 974.0600320690514, 989.0505115089522, 992.8758905136858, 994.1798016636268, 1006.5671761142705, 1017.4302390661217, 1019.5513973851519, 1020.6223697231998, 1023.5905637744887, 1065.6110519660308, 1066.3761699405857, 1067.236925598197, 1068.1188019883627, 1069.6790962711154, 1062.282959002674, 1065.8561094252293, 1065.9467026648636, 1067.3009178987775, 1068.1668298727006, 780.2275747010475, 784.1100351101484, 784.1217836023633, 784.3685832904509, 785.6857257097207, 16025.839741602667, 16180.595485112848, 16282.51152465416, 17174.74237886433, 17239.31042758288, 11614.419279036014, 14803.40786368544, 14812.851871481254, 14853.48012819557, 14901.776473352907, 12341.568045118378, 12801.295928723917, 13380.665483362896, 13394.933025334909, 13515.121517101357, 3406.863725450979, 3440.913977150566, 3442.8278586070596, 3444.4661077533024, 3453.4301840196335, 108899.45550272278, 109141.0, 110902.33646495308, 110944.0, 111836.99999999919, 11456.19806613529, 11466.2546934449, 11492.655220343404, 11496.942515287537, 11552.884471155348, 24351.14770983007, 24715.62926556103, 24921.75078249194, 25136.622950655754, 25193.0, 7718.382529397747, 7727.884081738778, 7782.416318776114, 7896.7236146734585, 7935.56354400502, 4060.2285565742413, 4083.612056854594, 4089.7137200395687, 4111.075008123148, 4145.771982540929, 4255.255330317182, 4304.7632380218765, 4314.935275970863, 4348.695591308578, 4354.8911277217685, 929.4934260827865, 946.6071580294239, 956.4404823178379, 959.510649568725, 960.6685693435753, 522.9084910140787, 612.7977767336769, 621.552482212806, 633.3160186998031, 661.5369241530948, 9583.0, 9822.0, 10196.439195844152, 10212.0, 10363.378197308186, 545.6562365709577, 599.5892813422819, 620.314552419579, 632.0613888375758, 654.5679851298121, 4491.164350073329, 4763.142634325785, 4816.638752093607, 4818.734969576707, 4823.659420110306, 92325.07674923165, 97705.0, 98388.50805745926, 98936.50531747295, 99004.0, 88022.3449274938, 88325.67511487333, 89987.55006225058, 91011.08988910026, 91863.0, 76344.61827690827, 76619.0, 76944.84582731263, 77047.22952770401, 78544.0, 9442.244620430212, 9457.243420526203, 9460.432374057578, 9477.241820654193, 9559.0, 38472.6152738469, 38601.227975440896, 40067.599324007555, 40662.10399492116, 42006.0, 67454.66272668606, 68149.0, 68479.3152068473, 69343.65328173326, 70024.0, 10923.0, 13519.0, 13830.308484575933, 14054.297285135906, 14188.645283867985, 13232.603021908973, 14091.929540352232, 14597.416103355747, 14605.853941460875, 15117.395304187708, 13611.795823062464, 13732.588022359345, 13750.518731844337, 13782.586522404345, 13988.37052332668, 13626.591202263948, 13683.931580342034, 13684.315784210949, 13709.0, 13825.585232443043, 13316.800247996094, 13476.9892258083, 13480.5281815136, 13579.388927498483, 13801.624072136781, 8828.558572071242, 9835.114839664464, 9909.900900990899, 10088.766391379471, 10677.57289708403, 10385.948070259601, 11065.0, 11107.333559986426, 11210.495527701436, 11223.55105795759], "value": 7792.5143163903995, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 121.0, 120.0, 123.0, 124.0, 122.0, 122.0, 124.0, 121.0, 121.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 120.0, 116.0, 159.0, 122.0, 120.0, 120.0, 118.0, 144.0, 119.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 214.0, 219.0, 217.0, 211.0, 210.0, 207.0, 213.0, 215.0, 210.0], "value": 212.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 91.0, 131.0, 83.0, 63.0, 65.0, 59.0, 85.0, 66.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 76.0, 101.0, 101.0, 112.0, 102.0, 94.0, 78.0, 112.0, 128.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 93.0, 92.0, 91.0, 91.0, 92.0, 91.0, 92.0, 91.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 101.0, 101.0, 126.0, 155.0, 136.0, 99.0, 101.0, 101.0, 131.0], "value": 115.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 101.0, 133.0, 162.0, 127.0, 98.0, 100.0, 101.0, 102.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 51.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 67.0, 87.0, 68.0, 65.0, 64.0, 61.0, 64.0, 62.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 95.0, 111.0, 119.0, 117.0, 88.0, 94.0, 91.0, 92.0, 90.0], "value": 97.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 148.0, 155.0, 145.0, 151.0, 148.0, 154.0, 208.0, 195.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 215.0, 225.0, 212.0, 198.0, 202.0, 209.0, 201.0, 204.0, 205.0], "value": 207.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 74.0, 74.0, 72.0, 73.0, 72.0, 75.0, 73.0, 72.0], "value": 73.5, "unit": "score"}]}]} 10:22:32 INFO - Return code: 0 10:22:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:32 ERROR - # TBPL SUCCESS # 10:22:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:22:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:22:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:22:32 INFO - 2017-04-05 10:22:32.761 screenresolution[1661:9917] starting screenresolution argv=screenresolution get 10:22:32 INFO - 2017-04-05 10:22:32.764 screenresolution[1661:9917] Display 0: 1600x1200x32@60 10:22:32 INFO - 2017-04-05 10:22:32.770 screenresolution[1662:9920] starting screenresolution argv=screenresolution list 10:22:32 INFO - Available Modes on Display 0 10:22:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:22:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:22:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:22:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:22:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:22:32 INFO - Intel Iris: 10:22:32 INFO - Chipset Model: Intel Iris 10:22:32 INFO - Type: GPU 10:22:32 INFO - Bus: Built-In 10:22:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:22:33 INFO - Vendor: Intel (0x8086) 10:22:33 INFO - Device ID: 0x0a2e 10:22:33 INFO - Revision ID: 0x0009 10:22:33 INFO - Displays: 10:22:33 INFO - Display: 10:22:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:22:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:22:33 INFO - Display Serial Number: 1600x1200 60 10:22:33 INFO - Main Display: Yes 10:22:33 INFO - Mirror: Off 10:22:33 INFO - Online: Yes 10:22:33 INFO - Rotation: Supported 10:22:33 INFO - Return code: 0 10:22:33 INFO - Running post-action listener: _resource_record_post_action 10:22:33 INFO - [mozharness: 2017-04-05 17:22:33.007507Z] Finished run-tests step (success) 10:22:33 INFO - Running post-run listener: _resource_record_post_run 10:22:33 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 37360640; Write bytes: 520929280; Read time: 378; Write time: 1797 10:22:33 INFO - TinderboxPrint: CPU usage
53.3% 10:22:33 INFO - TinderboxPrint: I/O read bytes / time
37,360,640 / 378 10:22:33 INFO - TinderboxPrint: I/O write bytes / time
520,929,280 / 1,797 10:22:33 INFO - TinderboxPrint: CPU idle
2,256.3 (46.7%) 10:22:33 INFO - TinderboxPrint: CPU system
962.7 (19.9%) 10:22:33 INFO - TinderboxPrint: CPU user
1,610.7 (33.3%) 10:22:33 INFO - TinderboxPrint: Swap in / out
244,174,848 / 0 10:22:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208101888; Write bytes: 210511872; Read time: 16096; Write time: 505 10:22:33 INFO - run-tests - Wall time: 1187s; CPU: 53.0%; Read bytes: 34509824; Write bytes: 308889600; Read time: 350; Write time: 1285 10:22:33 INFO - Running post-run listener: _upload_blobber_files 10:22:33 INFO - Blob upload gear active. 10:22:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:33 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 10:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:33 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:34 INFO - (blobuploader) - INFO - Done attempting. 10:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:35 INFO - (blobuploader) - INFO - Done attempting. 10:22:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:22:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:22:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:36 INFO - (blobuploader) - INFO - Done attempting. 10:22:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:39 INFO - (blobuploader) - INFO - Done attempting. 10:22:39 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:39 INFO - Return code: 0 10:22:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c94f856f368be5be5667e7f788e9f015851e07368cd5fe0417d21f2947b96d11fe30b3835e36150c128d48c679cc4cc7377c0e528acae76b356f44b17267649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a14075794b99ce58b7989c70a12bb785574145f9b82aa0c9002761cc2635ea5fd6ab8b237b4a06e605e65d48829b1c259bb95cfc33bddd7d1d5911740730c03e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c8566f9a9f91af41836d130f25a410604524380596533423e18062d5aedcef4207b722ec8deca552ae252d2025cb5bf455ef3ea79e071a892c09e81d355c45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c94561dac69feef4ee3e8f3423be45282b6cd219ca0f2228ce34f85d8e3e226810d2424e0a4311b62f722d286ad8987cb37f56930314a52a6c18a7a3c95d738"} 10:22:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:39 INFO - Contents: 10:22:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c94f856f368be5be5667e7f788e9f015851e07368cd5fe0417d21f2947b96d11fe30b3835e36150c128d48c679cc4cc7377c0e528acae76b356f44b17267649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a14075794b99ce58b7989c70a12bb785574145f9b82aa0c9002761cc2635ea5fd6ab8b237b4a06e605e65d48829b1c259bb95cfc33bddd7d1d5911740730c03e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c8566f9a9f91af41836d130f25a410604524380596533423e18062d5aedcef4207b722ec8deca552ae252d2025cb5bf455ef3ea79e071a892c09e81d355c45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c94561dac69feef4ee3e8f3423be45282b6cd219ca0f2228ce34f85d8e3e226810d2424e0a4311b62f722d286ad8987cb37f56930314a52a6c18a7a3c95d738"} 10:22:39 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:39 INFO - Copying logs to upload dir... 10:22:39 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.823575 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-04-05 10:22:39.418390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 10:22:39.422131) ========= 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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c94f856f368be5be5667e7f788e9f015851e07368cd5fe0417d21f2947b96d11fe30b3835e36150c128d48c679cc4cc7377c0e528acae76b356f44b17267649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a14075794b99ce58b7989c70a12bb785574145f9b82aa0c9002761cc2635ea5fd6ab8b237b4a06e605e65d48829b1c259bb95cfc33bddd7d1d5911740730c03e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c8566f9a9f91af41836d130f25a410604524380596533423e18062d5aedcef4207b722ec8deca552ae252d2025cb5bf455ef3ea79e071a892c09e81d355c45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c94561dac69feef4ee3e8f3423be45282b6cd219ca0f2228ce34f85d8e3e226810d2424e0a4311b62f722d286ad8987cb37f56930314a52a6c18a7a3c95d738"} build_url:https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/eVLf_vbBRn639JSQjnvS5w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c94f856f368be5be5667e7f788e9f015851e07368cd5fe0417d21f2947b96d11fe30b3835e36150c128d48c679cc4cc7377c0e528acae76b356f44b17267649", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a14075794b99ce58b7989c70a12bb785574145f9b82aa0c9002761cc2635ea5fd6ab8b237b4a06e605e65d48829b1c259bb95cfc33bddd7d1d5911740730c03e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c8566f9a9f91af41836d130f25a410604524380596533423e18062d5aedcef4207b722ec8deca552ae252d2025cb5bf455ef3ea79e071a892c09e81d355c45", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c94561dac69feef4ee3e8f3423be45282b6cd219ca0f2228ce34f85d8e3e226810d2424e0a4311b62f722d286ad8987cb37f56930314a52a6c18a7a3c95d738"}' ========= master_lag: 0.93 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 10:22:40.368108) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:22:40.368429) ========= 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.gDMERQ5I1c/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.1g76O5Ifnj/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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.005158 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 10:22:40.398610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 10:22:40.398905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 10:22:40.400018) ========= ========= Total master_lag: 1.41 =========