builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0235 starttime: 1472470778.18 results: success (0) buildid: 20160829025131 builduid: fe015c40c5de4388893bf40864ac7594 revision: d7e3cce681547fa168765f9e36e95ca135221cb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.178226) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.178837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.179251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.281163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.281561) ========= 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.N4KVgey520/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.RQFWjf0dGG/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 --2016-08-29 04:39:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-08-29 04:39:38 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.604260 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.910901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.911313) ========= 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.N4KVgey520/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.RQFWjf0dGG/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.025864 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.960821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:38.961184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d7e3cce681547fa168765f9e36e95ca135221cb5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d7e3cce681547fa168765f9e36e95ca135221cb5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N4KVgey520/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.RQFWjf0dGG/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 2016-08-29 04:39:39,000 truncating revision to first 12 chars 2016-08-29 04:39:39,000 Setting DEBUG logging. 2016-08-29 04:39:39,000 attempt 1/10 2016-08-29 04:39:39,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d7e3cce68154?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 04:39:39,647 unpacking tar archive at: fx-team-d7e3cce68154/testing/mozharness/ program finished with exit code 0 elapsedTime=0.907272 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:39.893486) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:39.893826) ========= script_repo_revision: d7e3cce681547fa168765f9e36e95ca135221cb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:39.894314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:39.894653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 04:39:39.913507) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-29 04:39:39.913897) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N4KVgey520/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.RQFWjf0dGG/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:39:40 INFO - MultiFileLogger online at 20160829 04:39:40 in /builds/slave/test 04:39:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:39:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:39:40 INFO - {'append_to_log': False, 04:39:40 INFO - 'base_work_dir': '/builds/slave/test', 04:39:40 INFO - 'blob_upload_branch': 'Fx-Team', 04:39:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:39:40 INFO - 'branch': 'Fx-Team', 04:39:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:39:40 INFO - 'config_files': ('talos/mac_config.py',), 04:39:40 INFO - 'default_actions': ('clobber', 04:39:40 INFO - 'read-buildbot-config', 04:39:40 INFO - 'download-and-extract', 04:39:40 INFO - 'populate-webroot', 04:39:40 INFO - 'create-virtualenv', 04:39:40 INFO - 'install', 04:39:40 INFO - 'run-tests'), 04:39:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:39:40 INFO - 'download_minidump_stackwalk': True, 04:39:40 INFO - 'download_symbols': 'ondemand', 04:39:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:39:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:39:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:39:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:39:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:39:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:39:40 INFO - 'installer_path': 'installer.exe', 04:39:40 INFO - 'log_level': 'info', 04:39:40 INFO - 'log_name': 'talos', 04:39:40 INFO - 'log_to_console': True, 04:39:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:39:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:39:40 INFO - 'opt_config_files': (), 04:39:40 INFO - 'pip_index': False, 04:39:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:39:40 INFO - 'cmd': ('bash', 04:39:40 INFO - '-c', 04:39:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:39:40 INFO - 'enabled': True, 04:39:40 INFO - 'halt_on_failure': False, 04:39:40 INFO - 'name': 'check_screen_resolution'},), 04:39:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:39:40 INFO - 'cmd': ('bash', 04:39:40 INFO - '-c', 04:39:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:39:40 INFO - 'enabled': True, 04:39:40 INFO - 'halt_on_failure': False, 04:39:40 INFO - 'name': 'check_screen_resolution'},), 04:39:40 INFO - 'run_cmd_checks_enabled': True, 04:39:40 INFO - 'sps_profile': False, 04:39:40 INFO - 'sps_profile_interval': 0, 04:39:40 INFO - 'suite': 'dromaeojs', 04:39:40 INFO - 'system_bits': '32', 04:39:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:39:40 INFO - 'title': 't-yosemite-r7-0235', 04:39:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:39:40 INFO - 'use_talos_json': True, 04:39:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:39:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:39:40 INFO - 'work_dir': 'build'} 04:39:40 INFO - [mozharness: 2016-08-29 11:39:40.060524Z] Running clobber step. 04:39:40 INFO - Running pre-action listener: _resource_record_pre_action 04:39:40 INFO - Running main action method: clobber 04:39:40 INFO - rmtree: /builds/slave/test/build 04:39:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:39:42 INFO - Running post-action listener: _resource_record_post_action 04:39:42 INFO - [mozharness: 2016-08-29 11:39:42.064304Z] Finished clobber step (success) 04:39:42 INFO - [mozharness: 2016-08-29 11:39:42.064452Z] Running read-buildbot-config step. 04:39:42 INFO - Running pre-action listener: _resource_record_pre_action 04:39:42 INFO - Running main action method: read_buildbot_config 04:39:42 INFO - Using buildbot properties: 04:39:42 INFO - { 04:39:42 INFO - "project": "", 04:39:42 INFO - "product": "firefox", 04:39:42 INFO - "script_repo_revision": "production", 04:39:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:39:42 INFO - "repository": "", 04:39:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:39:42 INFO - "buildid": "20160829025131", 04:39:42 INFO - "pgo_build": "False", 04:39:42 INFO - "basedir": "/builds/slave/test", 04:39:42 INFO - "buildnumber": 128, 04:39:42 INFO - "slavename": "t-yosemite-r7-0235", 04:39:42 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:39:42 INFO - "platform": "yosemite_r7", 04:39:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:39:42 INFO - "branch": "fx-team", 04:39:42 INFO - "repo_path": "integration/fx-team", 04:39:42 INFO - "revision": "d7e3cce681547fa168765f9e36e95ca135221cb5", 04:39:42 INFO - "stage_platform": "macosx64", 04:39:42 INFO - "builduid": "fe015c40c5de4388893bf40864ac7594", 04:39:42 INFO - "slavebuilddir": "test" 04:39:42 INFO - } 04:39:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:39:42 INFO - Running post-action listener: _resource_record_post_action 04:39:42 INFO - [mozharness: 2016-08-29 11:39:42.067809Z] Finished read-buildbot-config step (success) 04:39:42 INFO - [mozharness: 2016-08-29 11:39:42.067912Z] Running download-and-extract step. 04:39:42 INFO - Running pre-action listener: _resource_record_pre_action 04:39:42 INFO - Running main action method: download_and_extract 04:39:42 INFO - mkdir: /builds/slave/test/build/tests 04:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:42 INFO - trying https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:39:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 04:39:42 INFO - Downloaded 1199 bytes. 04:39:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:39:42 INFO - Using the following test package requirements: 04:39:42 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:39:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:39:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:39:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'jsshell-mac.zip'], 04:39:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:39:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:39:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:39:42 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:39:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:39:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:39:42 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:39:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:42 INFO - trying https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:39:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:39:44 INFO - Downloaded 16369355 bytes. 04:39:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:39:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:50 INFO - trying https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:39:50 INFO - Downloading https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:39:51 INFO - Downloaded 16369355 bytes. 04:39:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:39:58 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')]} 04:39:58 INFO - trying https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:39:58 INFO - Downloading https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:40:00 INFO - Downloaded 14413998 bytes. 04:40:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:00 INFO - trying https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:40:00 INFO - Downloading https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 04:40:03 INFO - Downloaded 111549471 bytes. 04:40:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:40:03 INFO - mkdir: /builds/slave/test/properties 04:40:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:03 INFO - Contents: 04:40:03 INFO - build_url:https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:40:04 INFO - Running post-action listener: _resource_record_post_action 04:40:04 INFO - Running post-action listener: set_extra_try_arguments 04:40:04 INFO - [mozharness: 2016-08-29 11:40:04.292523Z] Finished download-and-extract step (success) 04:40:04 INFO - [mozharness: 2016-08-29 11:40:04.292650Z] Running populate-webroot step. 04:40:04 INFO - Running pre-action listener: _resource_record_pre_action 04:40:04 INFO - Running main action method: populate_webroot 04:40:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:04 INFO - '--tppagecycles', 04:40:04 INFO - '7'], 04:40:04 INFO - 'tests': ['tsvgm']}}, 04:40:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:40:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:40:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:40:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['damp', 'tps']}, 04:40:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'tests': ['damp', 'tps']}, 04:40:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['dromaeo_dom']}, 04:40:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['basic_compositor_video']}, 04:40:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:40:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['a11yr', 04:40:04 INFO - 'ts_paint', 04:40:04 INFO - 'tpaint', 04:40:04 INFO - 'sessionrestore', 04:40:04 INFO - 'sessionrestore_no_auto_restore', 04:40:04 INFO - 'tabpaint']}, 04:40:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:40:04 INFO - 'ts_paint', 04:40:04 INFO - 'tpaint', 04:40:04 INFO - 'sessionrestore', 04:40:04 INFO - 'sessionrestore_no_auto_restore', 04:40:04 INFO - 'tabpaint']}, 04:40:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:40:04 INFO - 'ts_paint', 04:40:04 INFO - 'tpaint', 04:40:04 INFO - 'sessionrestore', 04:40:04 INFO - 'sessionrestore_no_auto_restore', 04:40:04 INFO - 'tabpaint']}, 04:40:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:40:04 INFO - 'ts_paint', 04:40:04 INFO - 'tpaint', 04:40:04 INFO - 'sessionrestore', 04:40:04 INFO - 'sessionrestore_no_auto_restore', 04:40:04 INFO - 'tabpaint']}, 04:40:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['a11yr', 04:40:04 INFO - 'ts_paint', 04:40:04 INFO - 'tpaint', 04:40:04 INFO - 'sessionrestore', 04:40:04 INFO - 'sessionrestore_no_auto_restore', 04:40:04 INFO - 'tabpaint']}, 04:40:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['a11yr', 04:40:04 INFO - 'ts_paint', 04:40:04 INFO - 'tpaint', 04:40:04 INFO - 'sessionrestore', 04:40:04 INFO - 'sessionrestore_no_auto_restore', 04:40:04 INFO - 'tabpaint']}, 04:40:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['tsvgx', 04:40:04 INFO - 'tsvgr_opacity', 04:40:04 INFO - 'tart', 04:40:04 INFO - 'tscrollx', 04:40:04 INFO - 'cart']}, 04:40:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:40:04 INFO - 'tsvgr_opacity', 04:40:04 INFO - 'tart', 04:40:04 INFO - 'tscrollx', 04:40:04 INFO - 'cart']}, 04:40:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'talos_options': ['--disable-e10s'], 04:40:04 INFO - 'tests': ['tp5o']}, 04:40:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'tests': ['tp5o']}, 04:40:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'talos_options': ['--disable-e10s', 04:40:04 INFO - '--xperf_path', 04:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:04 INFO - 'tests': ['tp5n']}, 04:40:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:04 INFO - 'talos_options': ['--xperf_path', 04:40:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:04 INFO - 'tests': ['tp5n']}}, 04:40:04 INFO - 'talos.zip': {'path': '', 04:40:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:04 INFO - Running post-action listener: _resource_record_post_action 04:40:04 INFO - [mozharness: 2016-08-29 11:40:04.311513Z] Finished populate-webroot step (success) 04:40:04 INFO - [mozharness: 2016-08-29 11:40:04.311654Z] Running create-virtualenv step. 04:40:04 INFO - Running pre-action listener: _resource_record_pre_action 04:40:04 INFO - Running main action method: create_virtualenv 04:40:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:04 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 04:40:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:04 INFO - Using real prefix '/tools/python27' 04:40:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:07 INFO - Installing pip.................done. 04:40:07 INFO - Return code: 0 04:40:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40:07 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')]} 04:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:07 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')]} 04:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:07 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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:07 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 04:40:07 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 04:40:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:07 INFO - 'HOME': '/Users/cltbld', 04:40:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:07 INFO - 'LOGNAME': 'cltbld', 04:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:07 INFO - 'MOZ_NO_REMOTE': '1', 04:40:07 INFO - 'NO_EM_RESTART': '1', 04:40:07 INFO - 'PAGER': '/bin/cat', 04:40:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:07 INFO - 'PWD': '/builds/slave/test', 04:40:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:07 INFO - 'SHELL': '/bin/bash', 04:40:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:07 INFO - 'USER': 'cltbld', 04:40:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:07 INFO - 'XPC_FLAGS': '0x0', 04:40:07 INFO - 'XPC_SERVICE_NAME': '0', 04:40:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:08 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 04:40:08 INFO - Cleaning up... 04:40:08 INFO - Return code: 0 04:40:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:08 INFO - 'HOME': '/Users/cltbld', 04:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:08 INFO - 'LOGNAME': 'cltbld', 04:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:08 INFO - 'MOZ_NO_REMOTE': '1', 04:40:08 INFO - 'NO_EM_RESTART': '1', 04:40:08 INFO - 'PAGER': '/bin/cat', 04:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:08 INFO - 'PWD': '/builds/slave/test', 04:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:08 INFO - 'SHELL': '/bin/bash', 04:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:08 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:08 INFO - 'USER': 'cltbld', 04:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:08 INFO - 'XPC_FLAGS': '0x0', 04:40:08 INFO - 'XPC_SERVICE_NAME': '0', 04:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:08 INFO - Downloading/unpacking psutil>=3.1.1 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:11 INFO - Installing collected packages: psutil 04:40:11 INFO - Running setup.py install for psutil 04:40:11 INFO - building 'psutil._psutil_osx' extension 04:40:11 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 04:40:12 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 04:40:12 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 04:40:12 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 04:40:12 INFO - building 'psutil._psutil_posix' extension 04:40:12 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 04:40:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:40:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:40:12 INFO - ^ 04:40:12 INFO - 1 warning generated. 04:40:12 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 04:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:12 INFO - Successfully installed psutil 04:40:12 INFO - Cleaning up... 04:40:13 INFO - Return code: 0 04:40:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:40:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:13 INFO - 'HOME': '/Users/cltbld', 04:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:13 INFO - 'LOGNAME': 'cltbld', 04:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:13 INFO - 'MOZ_NO_REMOTE': '1', 04:40:13 INFO - 'NO_EM_RESTART': '1', 04:40:13 INFO - 'PAGER': '/bin/cat', 04:40:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:13 INFO - 'PWD': '/builds/slave/test', 04:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:13 INFO - 'SHELL': '/bin/bash', 04:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:13 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:13 INFO - 'USER': 'cltbld', 04:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:13 INFO - 'XPC_FLAGS': '0x0', 04:40:13 INFO - 'XPC_SERVICE_NAME': '0', 04:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:40:15 INFO - Installing collected packages: mozsystemmonitor 04:40:15 INFO - Running setup.py install for mozsystemmonitor 04:40:15 INFO - Successfully installed mozsystemmonitor 04:40:15 INFO - Cleaning up... 04:40:15 INFO - Return code: 0 04:40:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:15 INFO - 'HOME': '/Users/cltbld', 04:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:15 INFO - 'LOGNAME': 'cltbld', 04:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:15 INFO - 'MOZ_NO_REMOTE': '1', 04:40:15 INFO - 'NO_EM_RESTART': '1', 04:40:15 INFO - 'PAGER': '/bin/cat', 04:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:15 INFO - 'PWD': '/builds/slave/test', 04:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:15 INFO - 'SHELL': '/bin/bash', 04:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:15 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:15 INFO - 'USER': 'cltbld', 04:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:15 INFO - 'XPC_FLAGS': '0x0', 04:40:15 INFO - 'XPC_SERVICE_NAME': '0', 04:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:16 INFO - Downloading/unpacking jsonschema==2.5.1 04:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:40:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:40:19 INFO - warning: no files found matching '*.txt' 04:40:19 INFO - no previously-included directories found matching 'build' 04:40:19 INFO - no previously-included directories found matching 'dist' 04:40:19 INFO - no previously-included directories found matching '.git*' 04:40:19 INFO - Installing collected packages: jsonschema, functools32 04:40:19 INFO - Running setup.py install for functools32 04:40:19 INFO - warning: no files found matching '*.txt' 04:40:19 INFO - no previously-included directories found matching 'build' 04:40:19 INFO - no previously-included directories found matching 'dist' 04:40:19 INFO - no previously-included directories found matching '.git*' 04:40:19 INFO - Successfully installed jsonschema functools32 04:40:19 INFO - Cleaning up... 04:40:19 INFO - Return code: 0 04:40:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:19 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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:19 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 04:40:19 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 04:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:19 INFO - 'HOME': '/Users/cltbld', 04:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:19 INFO - 'LOGNAME': 'cltbld', 04:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:19 INFO - 'MOZ_NO_REMOTE': '1', 04:40:19 INFO - 'NO_EM_RESTART': '1', 04:40:19 INFO - 'PAGER': '/bin/cat', 04:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:19 INFO - 'PWD': '/builds/slave/test', 04:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:19 INFO - 'SHELL': '/bin/bash', 04:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:19 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:19 INFO - 'USER': 'cltbld', 04:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:19 INFO - 'XPC_FLAGS': '0x0', 04:40:19 INFO - 'XPC_SERVICE_NAME': '0', 04:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:40:19 INFO - Cleaning up... 04:40:19 INFO - Return code: 0 04:40:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:19 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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:19 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 04:40:19 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 04:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:19 INFO - 'HOME': '/Users/cltbld', 04:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:19 INFO - 'LOGNAME': 'cltbld', 04:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:19 INFO - 'MOZ_NO_REMOTE': '1', 04:40:19 INFO - 'NO_EM_RESTART': '1', 04:40:19 INFO - 'PAGER': '/bin/cat', 04:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:19 INFO - 'PWD': '/builds/slave/test', 04:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:19 INFO - 'SHELL': '/bin/bash', 04:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:19 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:19 INFO - 'USER': 'cltbld', 04:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:19 INFO - 'XPC_FLAGS': '0x0', 04:40:19 INFO - 'XPC_SERVICE_NAME': '0', 04:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:20 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 04:40:20 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 04:40:20 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 04:40:20 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 04:40:20 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 04:40:20 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 04:40:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:22 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 04:40:22 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 04:40:22 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 04:40:22 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 04:40:22 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 04:40:22 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 04:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:23 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 04:40:23 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 04:40:23 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 04:40:23 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 04:40:23 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 04:40:23 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 04:40:23 INFO - Downloading docopt-0.6.1.tar.gz 04:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:23 INFO - Running setup.py install for blobuploader 04:40:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:23 INFO - Running setup.py install for requests 04:40:24 INFO - Running setup.py install for docopt 04:40:24 INFO - Successfully installed blobuploader requests docopt 04:40:24 INFO - Cleaning up... 04:40:24 INFO - Return code: 0 04:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:24 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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:24 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 04:40:24 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 04:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:24 INFO - 'HOME': '/Users/cltbld', 04:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:24 INFO - 'LOGNAME': 'cltbld', 04:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:24 INFO - 'MOZ_NO_REMOTE': '1', 04:40:24 INFO - 'NO_EM_RESTART': '1', 04:40:24 INFO - 'PAGER': '/bin/cat', 04:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:24 INFO - 'PWD': '/builds/slave/test', 04:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:24 INFO - 'SHELL': '/bin/bash', 04:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:24 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:24 INFO - 'USER': 'cltbld', 04:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:24 INFO - 'XPC_FLAGS': '0x0', 04:40:24 INFO - 'XPC_SERVICE_NAME': '0', 04:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hIa9td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-dGRVPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-xp89v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ixsUgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-FnOTpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-SRexlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-c8V9NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-c5SPH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-30mm5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Rcc7lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bdiaYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-oOqM7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Foxo2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-JMrflr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-cRrGw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CWsv3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-dGH2y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:26 INFO - Running setup.py install for manifestparser 04:40:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:26 INFO - Running setup.py install for mozcrash 04:40:26 INFO - Running setup.py install for mozdebug 04:40:27 INFO - Running setup.py install for mozdevice 04:40:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Running setup.py install for mozfile 04:40:27 INFO - Running setup.py install for mozhttpd 04:40:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Running setup.py install for mozinfo 04:40:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Running setup.py install for mozInstall 04:40:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:27 INFO - Running setup.py install for mozleak 04:40:27 INFO - Running setup.py install for mozlog 04:40:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:28 INFO - Running setup.py install for moznetwork 04:40:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:28 INFO - Running setup.py install for mozprocess 04:40:28 INFO - Running setup.py install for mozprofile 04:40:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:28 INFO - Running setup.py install for mozrunner 04:40:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:28 INFO - Running setup.py install for mozscreenshot 04:40:28 INFO - Running setup.py install for moztest 04:40:29 INFO - Running setup.py install for mozversion 04:40:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:29 INFO - Cleaning up... 04:40:29 INFO - Return code: 0 04:40:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:29 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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:29 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 04:40:29 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 04:40:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:29 INFO - 'HOME': '/Users/cltbld', 04:40:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:29 INFO - 'LOGNAME': 'cltbld', 04:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:29 INFO - 'MOZ_NO_REMOTE': '1', 04:40:29 INFO - 'NO_EM_RESTART': '1', 04:40:29 INFO - 'PAGER': '/bin/cat', 04:40:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:29 INFO - 'PWD': '/builds/slave/test', 04:40:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:29 INFO - 'SHELL': '/bin/bash', 04:40:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:29 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:29 INFO - 'USER': 'cltbld', 04:40:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:29 INFO - 'XPC_FLAGS': '0x0', 04:40:29 INFO - 'XPC_SERVICE_NAME': '0', 04:40:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-t45qPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:29 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)) 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-J8Gx95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HcgwZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:29 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)) 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-M9nNP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Tl1Evb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:29 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)) 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-0BwuA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:30 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-0LKfzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:30 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tBepeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:30 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-9NTvL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:30 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CxPPoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-F9cuEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:30 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-o8Dfsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-5MsD_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:30 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-RFgLrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-grcMdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:31 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)) 04:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:31 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Kxil0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 04:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:31 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-PcJwB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:31 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)) 04:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:40:31 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)) 04:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:31 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 04:40:31 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 04:40:31 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 04:40:31 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 04:40:31 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 04:40:31 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 04:40:33 INFO - Downloading blessings-1.6.tar.gz 04:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:40:33 INFO - Installing collected packages: blessings 04:40:33 INFO - Running setup.py install for blessings 04:40:33 INFO - Successfully installed blessings 04:40:33 INFO - Cleaning up... 04:40:34 INFO - Return code: 0 04:40:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:34 INFO - Reading from file tmpfile_stdout 04:40:34 INFO - Current package versions: 04:40:34 INFO - blessings == 1.6 04:40:34 INFO - blobuploader == 1.2.4 04:40:34 INFO - docopt == 0.6.1 04:40:34 INFO - functools32 == 3.2.3-2 04:40:34 INFO - jsonschema == 2.5.1 04:40:34 INFO - manifestparser == 1.1 04:40:34 INFO - mozInstall == 1.12 04:40:34 INFO - mozcrash == 0.17 04:40:34 INFO - mozdebug == 0.1 04:40:34 INFO - mozdevice == 0.48 04:40:34 INFO - mozfile == 1.2 04:40:34 INFO - mozhttpd == 0.7 04:40:34 INFO - mozinfo == 0.9 04:40:34 INFO - mozleak == 0.1 04:40:34 INFO - mozlog == 3.3 04:40:34 INFO - moznetwork == 0.27 04:40:34 INFO - mozprocess == 0.23 04:40:34 INFO - mozprofile == 0.28 04:40:34 INFO - mozrunner == 6.12 04:40:34 INFO - mozscreenshot == 0.1 04:40:34 INFO - mozsystemmonitor == 0.3 04:40:34 INFO - moztest == 0.7 04:40:34 INFO - mozversion == 1.4 04:40:34 INFO - psutil == 3.1.1 04:40:34 INFO - requests == 1.2.3 04:40:34 INFO - wsgiref == 0.1.2 04:40:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:34 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 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:34 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 04:40:34 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 04:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:34 INFO - 'HOME': '/Users/cltbld', 04:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:34 INFO - 'LOGNAME': 'cltbld', 04:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:34 INFO - 'MOZ_NO_REMOTE': '1', 04:40:34 INFO - 'NO_EM_RESTART': '1', 04:40:34 INFO - 'PAGER': '/bin/cat', 04:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:34 INFO - 'PWD': '/builds/slave/test', 04:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:34 INFO - 'SHELL': '/bin/bash', 04:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:34 INFO - 'USER': 'cltbld', 04:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:34 INFO - 'XPC_FLAGS': '0x0', 04:40:34 INFO - 'XPC_SERVICE_NAME': '0', 04:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 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)) 04:40:34 INFO - Cleaning up... 04:40:34 INFO - Return code: 0 04:40:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b008a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b09d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd1adad780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, '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.N4KVgey520/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.RQFWjf0dGG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 04:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:34 INFO - 'HOME': '/Users/cltbld', 04:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:34 INFO - 'LOGNAME': 'cltbld', 04:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:34 INFO - 'MOZ_NO_REMOTE': '1', 04:40:34 INFO - 'NO_EM_RESTART': '1', 04:40:34 INFO - 'PAGER': '/bin/cat', 04:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:34 INFO - 'PWD': '/builds/slave/test', 04:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:34 INFO - 'SHELL': '/bin/bash', 04:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:40:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:34 INFO - 'USER': 'cltbld', 04:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:34 INFO - 'XPC_FLAGS': '0x0', 04:40:34 INFO - 'XPC_SERVICE_NAME': '0', 04:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:40:34 INFO - Cleaning up... 04:40:34 INFO - Return code: 0 04:40:34 INFO - Running post-action listener: _resource_record_post_action 04:40:34 INFO - Running post-action listener: _start_resource_monitoring 04:40:34 INFO - Starting resource monitoring. 04:40:34 INFO - [mozharness: 2016-08-29 11:40:34.926066Z] Finished create-virtualenv step (success) 04:40:34 INFO - [mozharness: 2016-08-29 11:40:34.927025Z] Running install step. 04:40:34 INFO - Running pre-action listener: _resource_record_pre_action 04:40:34 INFO - Running main action method: install 04:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:35 INFO - Reading from file tmpfile_stdout 04:40:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:40:35 INFO - Reading from file tmpfile_stdout 04:40:35 INFO - Output received: 04:40:35 INFO - Usage: mozinstall [options] installer 04:40:35 INFO - Options: 04:40:35 INFO - -h, --help show this help message and exit 04:40:35 INFO - -d DEST, --destination=DEST 04:40:35 INFO - Directory to install application into. [default: 04:40:35 INFO - "/builds/slave/test"] 04:40:35 INFO - --app=APP Application being installed. [default: firefox] 04:40:35 INFO - mkdir: /builds/slave/test/build/application 04:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:41:09 INFO - Reading from file tmpfile_stdout 04:41:09 INFO - Output received: 04:41:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:41:09 INFO - Running post-action listener: _resource_record_post_action 04:41:09 INFO - [mozharness: 2016-08-29 11:41:09.438580Z] Finished install step (success) 04:41:09 INFO - [mozharness: 2016-08-29 11:41:09.438736Z] Running run-tests step. 04:41:09 INFO - Running pre-action listener: _resource_record_pre_action 04:41:09 INFO - Running main action method: run_tests 04:41:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:41:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:41:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:41:09 INFO - 2016-08-29 04:41:09.452 screenresolution[1711:8236] starting screenresolution argv=screenresolution get 04:41:09 INFO - 2016-08-29 04:41:09.455 screenresolution[1711:8236] Display 0: 1600x1200x32@60 04:41:09 INFO - 2016-08-29 04:41:09.461 screenresolution[1712:8238] starting screenresolution argv=screenresolution list 04:41:09 INFO - Available Modes on Display 0 04:41:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:41:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:41:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:41:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:41:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:41:09 INFO - Intel Iris: 04:41:09 INFO - Chipset Model: Intel Iris 04:41:09 INFO - Type: GPU 04:41:09 INFO - Bus: Built-In 04:41:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:41:09 INFO - Vendor: Intel (0x8086) 04:41:09 INFO - Device ID: 0x0a2e 04:41:09 INFO - Revision ID: 0x0009 04:41:09 INFO - Displays: 04:41:09 INFO - Display: 04:41:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:41:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:41:09 INFO - Display Serial Number: 1600x1200 60 04:41:09 INFO - Main Display: Yes 04:41:09 INFO - Mirror: Off 04:41:09 INFO - Online: Yes 04:41:09 INFO - Rotation: Supported 04:41:09 INFO - Return code: 0 04:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:09 INFO - Python 2.7.3 04:41:09 INFO - Return code: 0 04:41:09 INFO - grabbing minidump binary from tooltool 04:41: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')]} 04:41:09 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 0x10af6cd30>, '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 0x10acd1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af64b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:09 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 04:41:09 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 04:41:09 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 04:41:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:09 INFO - Return code: 0 04:41:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:41:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:41:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 04:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 04:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N4KVgey520/Render', 04:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:09 INFO - 'HOME': '/Users/cltbld', 04:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:09 INFO - 'LOGNAME': 'cltbld', 04:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:09 INFO - 'MOZ_NO_REMOTE': '1', 04:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:09 INFO - 'NO_EM_RESTART': '1', 04:41:09 INFO - 'PAGER': '/bin/cat', 04:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:09 INFO - 'PWD': '/builds/slave/test', 04:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:09 INFO - 'SHELL': '/bin/bash', 04:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RQFWjf0dGG/Listeners', 04:41:09 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 04:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:09 INFO - 'USER': 'cltbld', 04:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:09 INFO - 'XPC_FLAGS': '0x0', 04:41:09 INFO - 'XPC_SERVICE_NAME': '0', 04:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 04:41:10 INFO - mozversion application_buildid: 20160829025131 04:41:10 INFO - mozversion application_changeset: d7e3cce681547fa168765f9e36e95ca135221cb5 04:41:10 INFO - mozversion application_display_name: Nightly 04:41:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:10 INFO - mozversion application_name: Firefox 04:41:10 INFO - mozversion application_remotingname: firefox 04:41:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:41:10 INFO - mozversion application_vendor: Mozilla 04:41:10 INFO - mozversion application_version: 51.0a1 04:41:10 INFO - mozversion platform_buildid: 20160829025131 04:41:10 INFO - mozversion platform_changeset: d7e3cce681547fa168765f9e36e95ca135221cb5 04:41:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:41:10 INFO - mozversion platform_version: 51.0a1 04:41:10 INFO - using testdate: 1472470870 04:41:10 INFO - actual date: 1472470870 04:41:10 INFO - starting webserver on 'localhost:49267' 04:41:10 INFO - SUITE-START | Running 2 tests 04:41:10 INFO - TEST-START | dromaeo_css 04:41:10 INFO - operating with platform_type : mac_ 04:41:10 INFO - Initialising browser for dromaeo_css test... 04:41:10 INFO - TEST-INFO | started process 1722 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpPetVqA/profile http://localhost:49267/getInfo.html) 04:41:12 INFO - PROCESS | 1722 | __metrics Screen width/height:1600/1200 04:41:12 INFO - PROCESS | 1722 | colorDepth:24 04:41:12 INFO - PROCESS | 1722 | Browser inner width/height: 1024/689 04:41:12 INFO - PROCESS | 1722 | __metrics 04:41:12 INFO - PROCESS | 1722 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:41:12 INFO - PROCESS | 1722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:13 INFO - TEST-INFO | 1722: exit 0 04:41:13 INFO - Browser initialized. 04:41:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:41:13 INFO - TEST-INFO | started process 1726 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpPetVqA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:25 INFO - PROCESS | 1726 | RSS: Main: 234303488 04:41:25 INFO - PROCESS | 1726 | 04:42:16 INFO - PROCESS | 1726 | 1472470936847 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:44:27 INFO - PROCESS | 1726 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 04:44:29 INFO - PROCESS | 1726 | RSS: Main: 331612160 04:44:29 INFO - PROCESS | 1726 | 04:47:32 INFO - PROCESS | 1726 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 04:47:32 INFO - PROCESS | 1726 | RSS: Main: 369922048 04:47:32 INFO - PROCESS | 1726 | 04:50:35 INFO - PROCESS | 1726 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 04:50:35 INFO - PROCESS | 1726 | RSS: Main: 339193856 04:50:35 INFO - PROCESS | 1726 | 04:53:37 INFO - PROCESS | 1726 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 04:53:38 INFO - PROCESS | 1726 | RSS: Main: 328462336 04:53:38 INFO - PROCESS | 1726 | 04:56:41 INFO - PROCESS | 1726 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 04:56:42 INFO - PROCESS | 1726 | RSS: Main: 322904064 04:56:42 INFO - PROCESS | 1726 | 04:59:45 INFO - PROCESS | 1726 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 04:59:46 INFO - PROCESS | 1726 | RSS: Main: 435646464 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | __start_tp_report 04:59:46 INFO - PROCESS | 1726 | _x_x_mozilla_page_load 04:59:46 INFO - PROCESS | 1726 | _x_x_mozilla_page_load_details 04:59:46 INFO - PROCESS | 1726 | |i|pagename|runs| 04:59:46 INFO - PROCESS | 1726 | |0;dojo.html;3032.4238394705003;3374.8143852088137;3395.253044330248;3409.9829500852493;3456.1877958679706;5618.297712785902;5739.913901291474;5751.281089863767;5779.306483222009;5791.362950075493;5711.885762284752;5774.855628609297;5802.854928626786;5820.621659592123;5870.090136028912;5179.300794392747;5228.73856307185;5230.607704422165;5238.371395432553;5356.91964620531;5337.359516857982;5346.572274218072;5358.5981051421295;5376.301080859483;5407.83776486706;5189.610779191576;5220.451852555465;5222;5249.265102885599;5288.286081379041;5159.380874295071;5265.210218467222;5278.841634750964;5280.3663560372615;5291.603129765283;5176.120059589879;5184.040952423814;5194.298769666085;5224.164133738584;5224.895502089937;5727.770889164429;5746.224259724967;5754.251947246831;5790.073588225906;5805.245318108661;5234.293370394986;6081.604695694766;6155.938440615581;6277.843053923689;6291.905621415683;6247.281562620311;6281.466075383598;6285.182926219608;6295.779647712308;6314.526410519229;5813.215215945836;5817.854553636151;5827.125931110282;5829.7376618052285;5833.212516310328;5299.867503312371;6116.244470650255;6203.96898015507;6278.497720182374;6316.589421687576;6142.0383852415835;6155.753769849245;6169.01295792671;6169.81490555284;6174.938250617436;6255.093011513396;6263.404976527223;6276.246850377984;6282.277538083179;6297.874042519124;6074.179985701962;6106.733702294202;6129.387061293835;6172.753089876444;6184.350643182401;6184.196054512884;6194.039923811816;6234.875302493925;6244.469220116341;6258.874822503615;4927.827526036644;4937.679050861682;4938.160512712848;4939.431965324034;4952.504749525018;4394.2969124939855;4405.31717583775;4405.713628614129;4444.022315090675;4454.821807127679;5711.771529138788;5754.4533269339345;5763.904858077036;5783.306003279633;5831.562632802556;6229.875402491924;6267.341929097379;6285.465735412541;6290.150829638032;6306.369363063749;5601.60788744784;5746.396628354046;5749.223854779635;5781.075027995501;5782.10377391505;5346.331708536433;5348.598855085884;5399.946000540023;5411.512963833274;5459.344878614512;6298.527610429328;6310.5898116622275;6349.079383489368;6352.61884286935;6372.107904893412;6253.96873015632;6269.059641053878;6273.686315684106;6291.465225455888;6292.4966002720585;6186.969065154645;6220.595661282002;6237.282712488122;6267.811965641038;6325.841853953504;6219;6237.8752424950335;6239.656818875005;6244.438000579969;6253.6560489173535;4757.785899634594;6276.811695649138;6278.497720182466;6284.24589049317;6293.590916590407;5983.581149319506;6057.1519987200945;6061.848453788691;6110.541709371726;6134.957077260823;6100.066499260575;6144.556029333193;6145.709401025834;6146;6179.258488981351;5955.166276721349;6007.399260074132;6008.609440386361;6036.84907877289;6040.546958978182;6011.218541589566;6074.574779765374;6135.570510064253;6144.4777193937225;6148.50811935053;5990.131430942576;5991.610545314715;5997.16039754426;6005.429484199169;6039.275286965592 04:59:46 INFO - PROCESS | 1726 | |1;ext.html;457.70020636483105;469.8934010405495;496.739211913745;524.5881982643623;528.772627770059;29624;38322.616773832255;39313;39467.60532394675;41500.37749433753;41155.58844411555;41292.17415651685;41338;41397.79301103498;41439.58560414395;9306.534673266344;9522.476263805487;9700.708978730649;9710.368826026286;9721.659741909034;7796.6491507882;8705.390622656416;8713.869291960626;8787.95606021969;8804.031556528776;11632;11882.346470944094;11892.464839082262;12118.757624847498;12132;11908.880911190907;12002.579909703205;12019.759604807854;12042.397880106048;12053.939730301336;7315.780526584158;8326.333893288584;11510.194286399956;11725.648230553097;11733.4719937603;31153.688463115304;31573.368532629447;38212.61787382118;38709.22581548381;38771.224575508335;2966.7774916881103;3224.9677503224902;3280.4095262852675;3574.8748793792092;4037.735849056604;29858.253543661584;30049.399012019854;30350.392992140256;30526.84736576325;30830.53754193689;2858.799304292202;3189.9043028709175;3200.0399880035898;3235.433799085174;3323.570864528252;621831;632802;633358.8332058357;635668;644461.1100278466;58816.11775823366;59446.51383715355;59507.404925950184;59553.40446595479;59628;52289;60285.0957235633;61095.694521528;61413.69293153506;62109.689451552455;15846.76229856553;15931.044137351795;15937.36250549965;15953;16012.679746405007;12219.389030548436;12341.50633974649;12355;12357.443915023845;12657.873421265853;15624.531264061869;15948.607708843534;17863.106844657716;18066.638667226583;18199.181036853373;7425.925740742631;7487.625618719042;7554;7572.886406703904;7588.734394296283;816.9019717633922;852.2883392367443;885.2608072259735;944.4663764972769;997.6607953295915;25533.361665958128;27371.58942615862;28177.71822281792;28506.85746571254;29942.35317057583;1053.7787064716495;1123.309164863603;1130.2032067392634;1134.0927258193412;1156.7455159864817;10651.520681569347;15269.465568705042;15291.464798731991;15560.743692164799;15563.299651515708;650438;655550;657535;659265;659968;55109.448905511235;55715.721421392635;55824.72087639617;55891.720541397844;55968.16047759287;1330.3680751643085;1337.9665508362368;1361.2717196299932;1364.126958746403;1367.0635614604028;23873.373928867462;28525.42949140964;29692.406151877272;30091.548626771055;30265.848670756506;47503.57489275327;47592.52407476019;47709.284360733924;47737.52262477331;47837.76081119572;553896;556185;556821;560276;560608;24939.62590561107;25994.35014124662;26125.216243512725;26162.345941351618;26206.34484137912;32273.677263227066;38252.6174738249;44017.77991110024;46016.7699161502;48030.03939921252;37803;37810.865674029825;38365.84196011107;38868.61131388763;39430.802845985585;37470;37642.61216490529;38227.80886095552;38573.035674108374;38939.80530097331;36877.44683829691;36968.81515592405;37152.44271335878;37630.059248519006;37803.432948505244;31966.328081260795;32964.1758956028;33472.330553389285;33650.49524257089;33689.494657579664;21434.78565214328;24753.62869556994;24843.006279748606;24876.253712388658;25248 04:59:46 INFO - PROCESS | 1726 | |2;jquery.html;378.5759948857282;378.76705825917054;388.4154347706702;402.0852560425031;410.9732867363621;14547.854521454783;14794.926025369872;15319.463818766346;20776.89611551942;21001.789982100174;18870.528236794085;20016;20328.390148295573;20384.898075509638;20839.47901302468;5866.354700982888;5984.3417224105315;6072.119542666311;6079.996800527908;6096.634201947875;5886.9705651471895;5952.7023648817385;6072.757089716428;6080.30076541199;6093.634381937076;4151.23202207591;5735.512481439083;6437.452816510602;6724.184470193045;6828.385445309921;5694;6658.56719313248;6766.729330826761;6768.69540870662;6785.287544807798;5865.413458654143;5867.530597552228;5869.706514674249;5899.174115623816;5901.763929442817;24606.53934606543;25491.23526294214;25550;25558.74441255582;25793.484130317287;2121.904514296845;2413.793103448276;2629.408383113803;2755.2423083651956;3122.2194451387154;14490.058146220463;15443.30505127272;15701.293441795147;15752.44866429681;15817.367305307775;1585.992070039654;1657.4033347994712;1873.4754268804757;1878.539757759344;1892.3755160796904;111495;114288;114502.42748786286;114514;115197;10082.19342452602;10268.691939241835;10395.220358473145;10554.155667546578;10798.78402431947;13327.200367977952;13358.666033349244;13359.532416365575;13388.464461421629;13402.463901444027;6473.838154046092;8345.833083338299;8359.331253499706;8488.618012189467;8489.787755306043;8349.707760228363;8380.790480237922;8417.28453081495;8563.058063612998;8577.914220857836;6252.187215661935;6413.486921046305;6423.710933008026;6425.614463132227;6556.737730490822;1818.054611601986;1858.5838410066858;1859.0983373064053;1863.69249073904;1867.7011678131435;727.316322656701;878.7363790862715;880.124276345028;926.6200857648332;933.7758937854866;20837.791622083587;21589.460263493223;21789.564208715736;21801;21880;837.6063250272363;886.2201262888746;949.3259785552335;953.1659797677032;1007.4106647611229;10219.029192226726;11257.324560526395;11646.184767066225;11653.475593598308;11701.239419437708;507011.65947931906;528650;534191;534291;535191;82715.5864220687;113074;118339;119419;123935.76064239422;895.7447127568612;984.2372161574837;1001.759577701361;1032.6385764982197;1040.0327695243495;18686.53283667919;19100.808991909904;19226.711599325743;19230;19477.61044779125;50512.73718157075;51350.74324628353;51633.7418312906;51838.70403239798;51867.740661296455;60006.39993600008;69224;70883.64558177382;71426.92859607215;74082;7529.698812047676;7697.576633285223;7775.339096176888;7806.297433231037;7883.2510911465615;11939.52241910314;12143.992482480584;12211.938940305241;12224.493978734516;12324.876751232372;9208.171264586219;9400.529973501161;10865.239433239598;10903.127749780157;11014.889851101387;10709.196810239107;10829.458527073772;10967.725806854893;11013.504392302206;11233.831492527783;11210.383428911487;11290.048652806765;11454.427278635869;11549.826752598885;11661.125415594033;6532.9346706534225;7924.9207507926485;7928.286454219148;7989.400794940287;8170.428070035278;10980.396078215776;11006.724831879266;11172.273802202832;11182.832257516306;11247.718807029889 04:59:46 INFO - PROCESS | 1726 | |3;mootools.html;1518.764591488319;1549.2408719727334;1738.3568079810464;1856.8236017578324;1906.2851430713474;8375.41372103953;8943.418677785947;8948.776280592972;8959.686410975617;8960.865587016184;7811.062672479296;8025.879611805813;8423.241908228258;8635.52504612246;8694.869576956351;2206.922757703481;2365.7042869641296;2371.5731168389684;2372.122314743547;2372.5373552157334;2335.754745751697;2349.553584818879;2378.2984019714227;2380.8928598213033;2384.3562238195677;2352.8588284702973;2365.27859003004;2376.869272190029;2378.8096952243777;2382.3686723018413;2328.557574060923;2341.988290058556;2346.753590872951;2348.4128967758147;2362.161432691387;2329.6738456616085;2336.707911511061;2349.89425475854;2351.165336305621;2351.953380745569;8749.562521873944;8841.513716745576;8880.467171969702;8897.73306800797;8902.109789021046;4312.935305970413;5293.947060529423;5296.073187192264;5298.284731561267;5298.894022119574;3565.3938830398893;3589.10272431892;3637.7089832813313;3654.488371627974;3686.447032945053;1092.6995076354067;1102.2614848051824;1105.4748994227677;1118.8433619293305;1129.1080046763047;11513.309201447857;11576.826347604709;11600.651980440685;11613.419329033599;11622.767544649145;3887.475190849199;4280.700350975402;4467.061916997467;4485.215087359699;4812.278158276286;9948.552315145836;9952.253580981456;9970.651027214013;9971.252156088321;9976.102150806462;5340.759665815048;5349.839504814861;5351.545118664957;5365.946340536622;5372.167314066326;4314.805833737427;4421.624161946271;4572.862814115582;4729.597984171384;4920.581750551171;3838.481804956351;3846.6345697158727;3979.8408063677707;3985.3822657488136;4015.1768887378603;1129.717570607348;1242.19257482637;1249.9875001250052;1257.792464243408;1275.6491964709778;777.4208214879951;850.6342272822621;892.9642814287356;900.6262401103469;936.8735220745249;5770.365259821417;5857.09215071656;5971.492423144082;5998.760049597967;6134.2332208473945;777.6740657179496;903.6069309850236;905.2124651553191;945.8061097475002;1007.5818535307765;3586.8206589670413;3964.8215830287704;3975.542812576533;4087.570805065485;4100.712950093465;10425.322354046963;10794.406307653155;10796.760971708612;10800.567977280978;10803.621873234557;10706.571737130427;10729.517171727135;10740.033396994308;10748.408837513856;10783.191260655482;7727.961360193163;8060.31487323584;8070.2333278338465;8100.068492123363;8199;5074.67014644047;5364.275822763877;5930.762769489172;5961.970190149022;6130.570860039755;9516.381435206966;9697.981711920147;10043.849342260019;10116.949415253172;10143.28996970205;9968.451735154636;10307.330023548446;10315.948420257851;10319.690409287734;10403.722827309373;7383.630818459163;7440.107187137578;7508.474406791691;7526.661300241392;7666.8083297918;8122.187781222067;8218;8227.161629237904;8227.71203007892;8232.464889782144;6915.446764258747;7163.140423149255;7300.744473943387;7389.002484664717;7569.1295501018085;7254.5647261164495;7290.4896657233485;7305.817354566178;7348;7465.477416580788;6908.5509441886115;6917.619530925847;6989.1962424321855;6992.0560724303605;7003.26465721092;4991.875203119951;5032.949670503248;5069.264956581349;5076.162433198629;5125.2568377585785;4957.206846904478;4974.602031837517;5066.493350664904;5240.240165175952;5264.184051472028 04:59:46 INFO - PROCESS | 1726 | |4;prototype.html;308.93666798306344;310.2569346415335;317.8347259425098;323.4291475545661;323.977321587489;5363.9463605363935;5421.969825733117;5462.23528705981;5476.644018138818;5491.835244942658;5430.8913821723545;5469.206964990074;5504.1285962772645;5508;5514.972425137878;3357.8824741134126;3411.982940085296;3678.540182477177;3956.4460975463458;4146.191492658918;3400.846961886721;4157.565639854261;4163.770992595406;4173.102782901676;4192.434021407117;4089.9386509202386;4111.985127287622;4118.043929133668;4123.711340206187;4136.5449800522065;3623.4564815277654;3830.9042273943096;3913.256481268564;4102.651274641659;4131.29767939448;2998.61018067652;3083;3544.2202715402827;3585.982070089659;3643.198496330803;4375.453068366454;4848.9757551212015;4894.926576101361;5290.867728306823;5314.229436731653;4147.709660323779;4636.4962920023145;4685.906281874378;4760.428748550196;4830.830920917786;5677.971610141964;5749.626274292157;5751.338596061465;5779.88440231193;5801.187833703285;3731.365667836474;4052.629211911036;4053.6149065838995;4056.4523789288364;4084.6732261419015;5102.591792656615;5540.4763689985175;5547.44525547446;5954.338082079576;6019.999999999956;3897.2595206910596;4063.0858056936954;4073.735207211522;4093.2222877653153;4136.379543068564;3504.0363899927215;4126.328836821092;4145.2124096421585;4152.024274295538;4165.66674666032;4243.2998555238655;4670.271999360259;4787.898783279865;4801.735904525215;4821.807127714852;4471.754053527087;4760;5028.76795185182;5300.44345343741;5802.982449126515;1214.5627574073326;1215.070471089617;1369.5275130080106;1398.6363545478248;1430.4564265579222;804.4409135650784;860.1613426908714;867.7873920889297;873.9512584898021;882.148726478951;4600.470945841204;5129.846104616868;5328.49379308965;5336.599755018389;5465.59008074396;5847.327557330961;5867.559933004956;5870.882582348415;5932.3474417814;5944.851378715567;5077.568406685399;5368;5412.891742165213;5414.269073675004;5419.729013549307;2795.692473827877;2966.006387860091;2972.885168061977;3068.861901214451;3119.844007799601;5165.66423182492;5705.74324155414;6156.230471191101;6177.444030037228;6208.385819686914;5125.69245845243;5982.20631847262;6043.365446628129;6129.417705317987;6167;5106.6680665758095;6012.789552365646;6060.878782424327;6075.453209211104;6103.725332360054;5544.506960614948;5611.410801865745;5789.102689083199;5905.114232865105;5931.110333450017;5187.651210685173;5281.894362112813;5684.7157642118555;5762.300121464262;5806.187133801355;5224.7126408047925;6049.425304596057;6065.512330409943;6078.5441091919165;6096.664683442454;3691.6123806999876;3848.9905496169167;4008.518977722692;4033.4756481657196;4051.5745846685672;4826.469088400203;5746.13807928814;5757;5770.307563092456;5849.022664588121;4965.726885021359;5644.491995720241;5651.943480565142;5699.971500142473;5719.342275638189;4972.8508144755715;5041.1430056889685;5166.3800343958965;5615.691136987505;5728.598998070095;4470.485894122217;5373.194020896896;5552.639078459887;5566;5571.439996800902;5374.919376209282;5449.536789372948;5579.2746942897165;5613.354464236501;5669.376368599368;4824.6863953842885;5492.780288788564;5495.258140151029;5520.972395137998;5561.193626924154 04:59:46 INFO - PROCESS | 1726 | |5;yui.html;636.4939872801126;719.507137610737;751.9135299440566;768.0936494935975;774.8798936164894;15190;15863.524094277162;15894.284757185926;15910.52268431946;15916.92041539792;12017.459214335355;14259.215743134124;14406.711865762705;14430.783538246935;14869.776953345681;659.6701649175412;669.9448368819105;729.8430837369964;833.0212000898949;884.8407286688393;849.218718778725;863.6156910174975;863.9028433888989;864.5245115186653;865.926396256319;924.0205382294755;924.339097545255;924.6347692661394;927.7587827164919;928.5774972387547;704.7850405626282;725.173302435219;729.16510595368;917.9632814687404;921.9858156028349;541.3774159716319;678.8302924268933;697.1808125452573;699.3950233048428;703.8205257659264;14680.55958321252;14705.411783528645;14721.705565888622;14722.631934201623;14738.70522589553;12839.358032098358;13620;13801.51694690691;13899.235542045184;14024.158550487004;11484.71288217793;12757.42591583381;12839.29383883886;13021.41403636829;13492.797608035888;4468.084042771224;4476.239039363316;4491.39366185564;4687.835925742583;4699.483056863743;122056;125084;128287.35856320753;131962;133033.3348333252;10940.835887461695;10971.725706857393;11013.724656883642;11278.15413843965;11315.717107072389;21616.243431479823;21831.235906743186;21838;21847.235346762787;22192.778072219393;7796.376289896794;7868.567228802356;8015.799605009922;8020.157883422156;8231.09457959624;4411.426514553087;4413.1394378095965;4477.417935668407;4489.6408287336935;4585.977070114628;3028.697130286954;3461.2731326421736;3627.5646922369483;3637.836297366625;3638.9992751992886;615.5137441421227;652.8008957268079;659.9406053455212;663.5852592129919;667.8564108716649;551.4650788734921;578.3869098755333;613.3314686991201;617.4350469320611;642.9292777794439;7685.807854803675;7940.888275641415;8529.786755331166;8964.8655270171;9004.8649270261;585.9003969325225;611.8500967263049;616.8642898562309;621.3761304494161;623.1960770605958;4010.5387880393546;4241.957580424218;4252.958025283825;4445.73325600465;5185.196294574347;158179;158357.41642583656;160256;160409;164291.3570864276;90038;132107;133873.33063334815;137470;138622;82871;110361;116125;118046.63906721989;118222.99999999828;10093.293469457067;10098.293119481566;10162.847557286499;10213.33613315132;10233.590656373663;59411.81176376535;59552.40447595469;64439.67780161069;65308;65953;95970;102310.48844755729;102336;102645.48677256567;105981.47009264905;13379;13604.319784010562;13889.583312500641;14053.859461405254;14066.015378923377;14433;14459.204743739196;14543;14616;14984.47554335593;13376.799348009983;13587.388567514288;13620.114692544952;14295.785563216352;14631.048981816148;13425.26161061151;13580.320983950565;13872.375743091787;14087.225202613954;14370.425182992563;13425.328733563478;13475.595732128051;13505.919526437665;13527.985401095155;13914.950894860405;10975.780484390427;11382.772344552897;11423.657290281304;11428.657140285804;11949.342786146846;11506.597269095542;11555.42222888869;11678.357690327113;11787.233829801036;11804.940975295069 04:59:46 INFO - PROCESS | 1726 | __end_tp_report 04:59:46 INFO - PROCESS | 1726 | __start_cc_report 04:59:46 INFO - PROCESS | 1726 | _x_x_mozilla_cycle_collect,1326 04:59:46 INFO - PROCESS | 1726 | __end_cc_report 04:59:46 INFO - PROCESS | 1726 | __startTimestamp1472471986118__endTimestamp 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | ------- Summary: start ------- 04:59:46 INFO - PROCESS | 1726 | Number of tests: 6 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | [#0] dojo.html Cycles:165 Average:5752.26 Median:5997.16 stddev:642.75 (10.7%) stddev-sans-first:608.28 04:59:46 INFO - PROCESS | 1726 | Values: 3032.4 3374.8 3395.3 3410.0 3456.2 5618.3 5739.9 5751.3 5779.3 5791.4 5711.9 5774.9 5802.9 5820.6 5870.1 5179.3 5228.7 5230.6 5238.4 5356.9 5337.4 5346.6 5358.6 5376.3 5407.8 5189.6 5220.5 5222.0 5249.3 5288.3 5159.4 5265.2 5278.8 5280.4 5291.6 5176.1 5184.0 5194.3 5224.2 5224.9 5727.8 5746.2 5754.3 5790.1 5805.2 5234.3 6081.6 6155.9 6277.8 6291.9 6247.3 6281.5 6285.2 6295.8 6314.5 5813.2 5817.9 5827.1 5829.7 5833.2 5299.9 6116.2 6204.0 6278.5 6316.6 6142.0 6155.8 6169.0 6169.8 6174.9 6255.1 6263.4 6276.2 6282.3 6297.9 6074.2 6106.7 6129.4 6172.8 6184.4 6184.2 6194.0 6234.9 6244.5 6258.9 4927.8 4937.7 4938.2 4939.4 4952.5 4394.3 4405.3 4405.7 4444.0 4454.8 5711.8 5754.5 5763.9 5783.3 5831.6 6229.9 6267.3 6285.5 6290.2 6306.4 5601.6 5746.4 5749.2 5781.1 5782.1 5346.3 5348.6 5399.9 5411.5 5459.3 6298.5 6310.6 6349.1 6352.6 6372.1 6254.0 6269.1 6273.7 6291.5 6292.5 6187.0 6220.6 6237.3 6267.8 6325.8 6219.0 6237.9 6239.7 6244.4 6253.7 4757.8 6276.8 6278.5 6284.2 6293.6 5983.6 6057.2 6061.8 6110.5 6135.0 6100.1 6144.6 6145.7 6146.0 6179.3 5955.2 6007.4 6008.6 6036.8 6040.5 6011.2 6074.6 6135.6 6144.5 6148.5 5990.1 5991.6 5997.2 6005.4 6039.3 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | [#1] ext.html Cycles:180 Average:73342.32 Median:37636.34 stddev:165387.83 (439.4%) stddev-sans-first:165761.25 04:59:46 INFO - PROCESS | 1726 | Values: 457.7 469.9 496.7 524.6 528.8 29624.0 38322.6 39313.0 39467.6 41500.4 41155.6 41292.2 41338.0 41397.8 41439.6 9306.5 9522.5 9700.7 9710.4 9721.7 7796.6 8705.4 8713.9 8788.0 8804.0 11632.0 11882.3 11892.5 12118.8 12132.0 11908.9 12002.6 12019.8 12042.4 12053.9 7315.8 8326.3 11510.2 11725.6 11733.5 31153.7 31573.4 38212.6 38709.2 38771.2 2966.8 3225.0 3280.4 3574.9 4037.7 29858.3 30049.4 30350.4 30526.8 30830.5 2858.8 3189.9 3200.0 3235.4 3323.6 621831.0 632802.0 633358.8 635668.0 644461.1 58816.1 59446.5 59507.4 59553.4 59628.0 52289.0 60285.1 61095.7 61413.7 62109.7 15846.8 15931.0 15937.4 15953.0 16012.7 12219.4 12341.5 12355.0 12357.4 12657.9 15624.5 15948.6 17863.1 18066.6 18199.2 7425.9 7487.6 7554.0 7572.9 7588.7 816.9 852.3 885.3 944.5 997.7 25533.4 27371.6 28177.7 28506.9 29942.4 1053.8 1123.3 1130.2 1134.1 1156.7 10651.5 15269.5 15291.5 15560.7 15563.3 650438.0 655550.0 657535.0 659265.0 659968.0 55109.4 55715.7 55824.7 55891.7 55968.2 1330.4 1338.0 1361.3 1364.1 1367.1 23873.4 28525.4 29692.4 30091.5 30265.8 47503.6 47592.5 47709.3 47737.5 47837.8 553896.0 556185.0 556821.0 560276.0 560608.0 24939.6 25994.4 26125.2 26162.3 26206.3 32273.7 38252.6 44017.8 46016.8 48030.0 37803.0 37810.9 38365.8 38868.6 39430.8 37470.0 37642.6 38227.8 38573.0 38939.8 36877.4 36968.8 37152.4 37630.1 37803.4 31966.3 32964.2 33472.3 33650.5 33689.5 21434.8 24753.6 24843.0 24876.3 25248.0 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | [#2] jquery.html Cycles:180 Average:32280.50 Median:25554.37 stddev:88170.83 (345.0%) stddev-sans-first:88385.63 04:59:46 INFO - PROCESS | 1726 | Values: 378.6 378.8 388.4 402.1 411.0 14547.9 14794.9 15319.5 20776.9 21001.8 18870.5 20016.0 20328.4 20384.9 20839.5 5866.4 5984.3 6072.1 6080.0 6096.6 5887.0 5952.7 6072.8 6080.3 6093.6 4151.2 5735.5 6437.5 6724.2 6828.4 5694.0 6658.6 6766.7 6768.7 6785.3 5865.4 5867.5 5869.7 5899.2 5901.8 24606.5 25491.2 25550.0 25558.7 25793.5 2121.9 2413.8 2629.4 2755.2 3122.2 14490.1 15443.3 15701.3 15752.4 15817.4 1586.0 1657.4 1873.5 1878.5 1892.4 111495.0 114288.0 114502.4 114514.0 115197.0 10082.2 10268.7 10395.2 10554.2 10798.8 13327.2 13358.7 13359.5 13388.5 13402.5 6473.8 8345.8 8359.3 8488.6 8489.8 8349.7 8380.8 8417.3 8563.1 8577.9 6252.2 6413.5 6423.7 6425.6 6556.7 1818.1 1858.6 1859.1 1863.7 1867.7 727.3 878.7 880.1 926.6 933.8 20837.8 21589.5 21789.6 21801.0 21880.0 837.6 886.2 949.3 953.2 1007.4 10219.0 11257.3 11646.2 11653.5 11701.2 507011.7 528650.0 534191.0 534291.0 535191.0 82715.6 113074.0 118339.0 119419.0 123935.8 895.7 984.2 1001.8 1032.6 1040.0 18686.5 19100.8 19226.7 19230.0 19477.6 50512.7 51350.7 51633.7 51838.7 51867.7 60006.4 69224.0 70883.6 71426.9 74082.0 7529.7 7697.6 7775.3 7806.3 7883.3 11939.5 12144.0 12211.9 12224.5 12324.9 9208.2 9400.5 10865.2 10903.1 11014.9 10709.2 10829.5 10967.7 11013.5 11233.8 11210.4 11290.0 11454.4 11549.8 11661.1 6532.9 7924.9 7928.3 7989.4 8170.4 10980.4 11006.7 11172.3 11182.8 11247.7 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | [#3] mootools.html Cycles:180 Average:5689.74 Median:4983.24 stddev:3194.13 (64.1%) stddev-sans-first:3187.71 04:59:46 INFO - PROCESS | 1726 | Values: 1518.8 1549.2 1738.4 1856.8 1906.3 8375.4 8943.4 8948.8 8959.7 8960.9 7811.1 8025.9 8423.2 8635.5 8694.9 2206.9 2365.7 2371.6 2372.1 2372.5 2335.8 2349.6 2378.3 2380.9 2384.4 2352.9 2365.3 2376.9 2378.8 2382.4 2328.6 2342.0 2346.8 2348.4 2362.2 2329.7 2336.7 2349.9 2351.2 2352.0 8749.6 8841.5 8880.5 8897.7 8902.1 4312.9 5293.9 5296.1 5298.3 5298.9 3565.4 3589.1 3637.7 3654.5 3686.4 1092.7 1102.3 1105.5 1118.8 1129.1 11513.3 11576.8 11600.7 11613.4 11622.8 3887.5 4280.7 4467.1 4485.2 4812.3 9948.6 9952.3 9970.7 9971.3 9976.1 5340.8 5349.8 5351.5 5365.9 5372.2 4314.8 4421.6 4572.9 4729.6 4920.6 3838.5 3846.6 3979.8 3985.4 4015.2 1129.7 1242.2 1250.0 1257.8 1275.6 777.4 850.6 893.0 900.6 936.9 5770.4 5857.1 5971.5 5998.8 6134.2 777.7 903.6 905.2 945.8 1007.6 3586.8 3964.8 3975.5 4087.6 4100.7 10425.3 10794.4 10796.8 10800.6 10803.6 10706.6 10729.5 10740.0 10748.4 10783.2 7728.0 8060.3 8070.2 8100.1 8199.0 5074.7 5364.3 5930.8 5962.0 6130.6 9516.4 9698.0 10043.8 10116.9 10143.3 9968.5 10307.3 10315.9 10319.7 10403.7 7383.6 7440.1 7508.5 7526.7 7666.8 8122.2 8218.0 8227.2 8227.7 8232.5 6915.4 7163.1 7300.7 7389.0 7569.1 7254.6 7290.5 7305.8 7348.0 7465.5 6908.6 6917.6 6989.2 6992.1 7003.3 4991.9 5032.9 5069.3 5076.2 5125.3 4957.2 4974.6 5066.5 5240.2 5264.2 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | [#4] prototype.html Cycles:180 Average:4614.66 Median:5206.18 stddev:1425.87 (27.4%) stddev-sans-first:1392.76 04:59:46 INFO - PROCESS | 1726 | Values: 308.9 310.3 317.8 323.4 324.0 5363.9 5422.0 5462.2 5476.6 5491.8 5430.9 5469.2 5504.1 5508.0 5515.0 3357.9 3412.0 3678.5 3956.4 4146.2 3400.8 4157.6 4163.8 4173.1 4192.4 4089.9 4112.0 4118.0 4123.7 4136.5 3623.5 3830.9 3913.3 4102.7 4131.3 2998.6 3083.0 3544.2 3586.0 3643.2 4375.5 4849.0 4894.9 5290.9 5314.2 4147.7 4636.5 4685.9 4760.4 4830.8 5678.0 5749.6 5751.3 5779.9 5801.2 3731.4 4052.6 4053.6 4056.5 4084.7 5102.6 5540.5 5547.4 5954.3 6020.0 3897.3 4063.1 4073.7 4093.2 4136.4 3504.0 4126.3 4145.2 4152.0 4165.7 4243.3 4670.3 4787.9 4801.7 4821.8 4471.8 4760.0 5028.8 5300.4 5803.0 1214.6 1215.1 1369.5 1398.6 1430.5 804.4 860.2 867.8 874.0 882.1 4600.5 5129.8 5328.5 5336.6 5465.6 5847.3 5867.6 5870.9 5932.3 5944.9 5077.6 5368.0 5412.9 5414.3 5419.7 2795.7 2966.0 2972.9 3068.9 3119.8 5165.7 5705.7 6156.2 6177.4 6208.4 5125.7 5982.2 6043.4 6129.4 6167.0 5106.7 6012.8 6060.9 6075.5 6103.7 5544.5 5611.4 5789.1 5905.1 5931.1 5187.7 5281.9 5684.7 5762.3 5806.2 5224.7 6049.4 6065.5 6078.5 6096.7 3691.6 3849.0 4008.5 4033.5 4051.6 4826.5 5746.1 5757.0 5770.3 5849.0 4965.7 5644.5 5651.9 5700.0 5719.3 4972.9 5041.1 5166.4 5615.7 5728.6 4470.5 5373.2 5552.6 5566.0 5571.4 5374.9 5449.5 5579.3 5613.4 5669.4 4824.7 5492.8 5495.3 5521.0 5561.2 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - PROCESS | 1726 | [#5] yui.html Cycles:180 Average:25985.17 Median:162350.18 stddev:42196.53 (26.0%) stddev-sans-first:42271.98 04:59:46 INFO - PROCESS | 1726 | Values: 636.5 719.5 751.9 768.1 774.9 15190.0 15863.5 15894.3 15910.5 15916.9 12017.5 14259.2 14406.7 14430.8 14869.8 659.7 669.9 729.8 833.0 884.8 849.2 863.6 863.9 864.5 865.9 924.0 924.3 924.6 927.8 928.6 704.8 725.2 729.2 918.0 922.0 541.4 678.8 697.2 699.4 703.8 14680.6 14705.4 14721.7 14722.6 14738.7 12839.4 13620.0 13801.5 13899.2 14024.2 11484.7 12757.4 12839.3 13021.4 13492.8 4468.1 4476.2 4491.4 4687.8 4699.5 122056.0 125084.0 128287.4 131962.0 133033.3 10940.8 10971.7 11013.7 11278.2 11315.7 21616.2 21831.2 21838.0 21847.2 22192.8 7796.4 7868.6 8015.8 8020.2 8231.1 4411.4 4413.1 4477.4 4489.6 4586.0 3028.7 3461.3 3627.6 3637.8 3639.0 615.5 652.8 659.9 663.6 667.9 551.5 578.4 613.3 617.4 642.9 7685.8 7940.9 8529.8 8964.9 9004.9 585.9 611.9 616.9 621.4 623.2 4010.5 4242.0 4253.0 4445.7 5185.2 158179.0 158357.4 160256.0 160409.0 164291.4 90038.0 132107.0 133873.3 137470.0 138622.0 82871.0 110361.0 116125.0 118046.6 118223.0 10093.3 10098.3 10162.8 10213.3 10233.6 59411.8 59552.4 64439.7 65308.0 65953.0 95970.0 102310.5 102336.0 102645.5 105981.5 13379.0 13604.3 13889.6 14053.9 14066.0 14433.0 14459.2 14543.0 14616.0 14984.5 13376.8 13587.4 13620.1 14295.8 14631.0 13425.3 13580.3 13872.4 14087.2 14370.4 13425.3 13475.6 13505.9 13528.0 13915.0 10975.8 11382.8 11423.7 11428.7 11949.3 11506.6 11555.4 11678.4 11787.2 11804.9 04:59:46 INFO - PROCESS | 1726 | -------- Summary: end -------- 04:59:46 INFO - PROCESS | 1726 | 04:59:46 INFO - TEST-INFO | 1726: exit 0 04:59:46 INFO - TEST-OK | dromaeo_css | took 1116648ms 04:59:46 INFO - TEST-START | kraken 04:59:46 INFO - operating with platform_type : mac_ 04:59:46 INFO - Initialising browser for kraken test... 04:59:46 INFO - TEST-INFO | started process 1842 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpGA1Suz/profile http://localhost:49267/getInfo.html) 04:59:48 INFO - PROCESS | 1842 | __metrics Screen width/height:1600/1200 04:59:48 INFO - PROCESS | 1842 | colorDepth:24 04:59:48 INFO - PROCESS | 1842 | Browser inner width/height: 1024/689 04:59:48 INFO - PROCESS | 1842 | __metrics 04:59:48 INFO - PROCESS | 1842 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:59:48 INFO - PROCESS | 1842 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:59:49 INFO - TEST-INFO | 1842: exit 0 04:59:49 INFO - Browser initialized. 04:59:49 INFO - Running cycle 1/1 for kraken test... 04:59:49 INFO - TEST-INFO | started process 1843 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpGA1Suz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:01 INFO - PROCESS | 1843 | RSS: Main: 234373120 05:00:01 INFO - PROCESS | 1843 | 05:00:04 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:05 INFO - PROCESS | 1843 | RSS: Main: 292425728 05:00:05 INFO - PROCESS | 1843 | 05:00:07 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 05:00:08 INFO - PROCESS | 1843 | RSS: Main: 287899648 05:00:08 INFO - PROCESS | 1843 | 05:00:11 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 05:00:12 INFO - PROCESS | 1843 | RSS: Main: 379047936 05:00:12 INFO - PROCESS | 1843 | 05:00:14 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 05:00:15 INFO - PROCESS | 1843 | RSS: Main: 279855104 05:00:15 INFO - PROCESS | 1843 | 05:00:17 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:18 INFO - PROCESS | 1843 | RSS: Main: 283144192 05:00:18 INFO - PROCESS | 1843 | 05:00:20 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:21 INFO - PROCESS | 1843 | RSS: Main: 322019328 05:00:21 INFO - PROCESS | 1843 | 05:00:24 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:24 INFO - PROCESS | 1843 | RSS: Main: 322281472 05:00:24 INFO - PROCESS | 1843 | 05:00:27 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 05:00:28 INFO - PROCESS | 1843 | RSS: Main: 321056768 05:00:28 INFO - PROCESS | 1843 | 05:00:29 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:30 INFO - PROCESS | 1843 | RSS: Main: 296583168 05:00:30 INFO - PROCESS | 1843 | 05:00:32 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:32 INFO - PROCESS | 1843 | RSS: Main: 302874624 05:00:32 INFO - PROCESS | 1843 | 05:00:35 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:35 INFO - PROCESS | 1843 | RSS: Main: 304246784 05:00:35 INFO - PROCESS | 1843 | 05:00:38 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:39 INFO - PROCESS | 1843 | RSS: Main: 320311296 05:00:39 INFO - PROCESS | 1843 | 05:00:42 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:42 INFO - PROCESS | 1843 | RSS: Main: 317849600 05:00:42 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 05:00:44 INFO - PROCESS | 1843 | RSS: Main: 361148416 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | __start_tp_report 05:00:44 INFO - PROCESS | 1843 | _x_x_mozilla_page_load 05:00:44 INFO - PROCESS | 1843 | _x_x_mozilla_page_load_details 05:00:44 INFO - PROCESS | 1843 | |i|pagename|runs| 05:00:44 INFO - PROCESS | 1843 | |0;ai-astar;118;164;182;115;110;113;110;111;111;111 05:00:44 INFO - PROCESS | 1843 | |1;audio-beat-detection;146;114;126;160;109;130;128;107;160;108 05:00:44 INFO - PROCESS | 1843 | |2;audio-dft;185;184;184;183;184;187;178;183;183;182 05:00:44 INFO - PROCESS | 1843 | |3;audio-fft;72;76;77;156;82;81;80;55;146;80 05:00:44 INFO - PROCESS | 1843 | |4;audio-oscillator;81;82;132;71;71;83;119;68;69;119 05:00:44 INFO - PROCESS | 1843 | |5;imaging-gaussian-blur;86;88;86;83;87;83;86;83;86;83 05:00:44 INFO - PROCESS | 1843 | |6;imaging-darkroom;93;92;92;92;92;93;91;93;92;92 05:00:44 INFO - PROCESS | 1843 | |7;imaging-desaturate;83;86;86;87;85;124;133;96;85;87 05:00:44 INFO - PROCESS | 1843 | |8;json-parse-financial;52;54;54;54;53;55;55;54;54;53 05:00:44 INFO - PROCESS | 1843 | |9;json-stringify-tinderbox;68;66;70;82;76;72;71;71;69;71 05:00:44 INFO - PROCESS | 1843 | |10;stanford-crypto-aes;85;85;88;85;86;86;87;84;85;86 05:00:44 INFO - PROCESS | 1843 | |11;stanford-crypto-ccm;140;139;140;143;153;130;138;140;191;152 05:00:44 INFO - PROCESS | 1843 | |12;stanford-crypto-pbkdf2;170;167;169;170;169;166;172;168;167;166 05:00:44 INFO - PROCESS | 1843 | |13;stanford-crypto-sha256-iterative;67;67;68;68;68;68;68;68;66;66 05:00:44 INFO - PROCESS | 1843 | __end_tp_report 05:00:44 INFO - PROCESS | 1843 | __start_cc_report 05:00:44 INFO - PROCESS | 1843 | _x_x_mozilla_cycle_collect,2010 05:00:44 INFO - PROCESS | 1843 | __end_cc_report 05:00:44 INFO - PROCESS | 1843 | __startTimestamp1472472044841__endTimestamp 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | ------- Summary: start ------- 05:00:44 INFO - PROCESS | 1843 | Number of tests: 14 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#0] ai-astar Cycles:10 Average:124.50 Median:114.00 stddev:26.03 (22.8%) stddev-sans-first:27.50 05:00:44 INFO - PROCESS | 1843 | Values: 118.0 164.0 182.0 115.0 110.0 113.0 110.0 111.0 111.0 111.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:129.00 stddev:20.47 (15.9%) stddev-sans-first:20.75 05:00:44 INFO - PROCESS | 1843 | Values: 146.0 114.0 126.0 160.0 109.0 130.0 128.0 107.0 160.0 108.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.31 (1.3%) stddev-sans-first:2.37 05:00:44 INFO - PROCESS | 1843 | Values: 185.0 184.0 184.0 183.0 184.0 187.0 178.0 183.0 183.0 182.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#3] audio-fft Cycles:10 Average:90.50 Median:78.50 stddev:32.91 (41.9%) stddev-sans-first:34.22 05:00:44 INFO - PROCESS | 1843 | Values: 72.0 76.0 77.0 156.0 82.0 81.0 80.0 55.0 146.0 80.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:71.00 stddev:24.23 (34.1%) stddev-sans-first:25.51 05:00:44 INFO - PROCESS | 1843 | Values: 81.0 82.0 132.0 71.0 71.0 83.0 119.0 68.0 69.0 119.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:2.00 05:00:44 INFO - PROCESS | 1843 | Values: 86.0 88.0 86.0 83.0 87.0 83.0 86.0 83.0 86.0 83.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 05:00:44 INFO - PROCESS | 1843 | Values: 93.0 92.0 92.0 92.0 92.0 93.0 91.0 93.0 92.0 92.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:86.00 stddev:18.01 (20.9%) stddev-sans-first:18.55 05:00:44 INFO - PROCESS | 1843 | Values: 83.0 86.0 86.0 87.0 85.0 124.0 133.0 96.0 85.0 87.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.71 05:00:44 INFO - PROCESS | 1843 | Values: 52.0 54.0 54.0 54.0 53.0 55.0 55.0 54.0 54.0 53.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:4.50 (6.3%) stddev-sans-first:4.58 05:00:44 INFO - PROCESS | 1843 | Values: 68.0 66.0 70.0 82.0 76.0 72.0 71.0 71.0 69.0 71.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 05:00:44 INFO - PROCESS | 1843 | Values: 85.0 85.0 88.0 85.0 86.0 86.0 87.0 84.0 85.0 86.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:141.50 stddev:16.97 (12.0%) stddev-sans-first:17.83 05:00:44 INFO - PROCESS | 1843 | Values: 140.0 139.0 140.0 143.0 153.0 130.0 138.0 140.0 191.0 152.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:1.96 (1.2%) stddev-sans-first:1.99 05:00:44 INFO - PROCESS | 1843 | Values: 170.0 167.0 169.0 170.0 169.0 166.0 172.0 168.0 167.0 166.0 05:00:44 INFO - PROCESS | 1843 | 05:00:44 INFO - PROCESS | 1843 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 05:00:44 INFO - PROCESS | 1843 | Values: 67.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 66.0 66.0 05:00:44 INFO - PROCESS | 1843 | -------- Summary: end -------- 05:00:44 INFO - PROCESS | 1843 | 05:00:45 INFO - TEST-INFO | 1843: exit 0 05:00:45 INFO - TEST-OK | kraken | took 58961ms 05:00:45 INFO - SUITE-END | took 1175s 05:00:45 INFO - Completed test suite (00:19:35) 05:00:45 INFO - javascript benchmark 05:00:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.4238394705003, 3374.8143852088137, 3395.253044330248, 3409.9829500852493, 3456.1877958679706, 5618.297712785902, 5739.913901291474, 5751.281089863767, 5779.306483222009, 5791.362950075493, 5711.885762284752, 5774.855628609297, 5802.854928626786, 5820.621659592123, 5870.090136028912, 5179.300794392747, 5228.73856307185, 5230.607704422165, 5238.371395432553, 5356.91964620531, 5337.359516857982, 5346.572274218072, 5358.5981051421295, 5376.301080859483, 5407.83776486706, 5189.610779191576, 5220.451852555465, 5222.0, 5249.265102885599, 5288.286081379041, 5159.380874295071, 5265.210218467222, 5278.841634750964, 5280.3663560372615, 5291.603129765283, 5176.120059589879, 5184.040952423814, 5194.298769666085, 5224.164133738584, 5224.895502089937, 5727.770889164429, 5746.224259724967, 5754.251947246831, 5790.073588225906, 5805.245318108661, 5234.293370394986, 6081.604695694766, 6155.938440615581, 6277.843053923689, 6291.905621415683, 6247.281562620311, 6281.466075383598, 6285.182926219608, 6295.779647712308, 6314.526410519229, 5813.215215945836, 5817.854553636151, 5827.125931110282, 5829.7376618052285, 5833.212516310328, 5299.867503312371, 6116.244470650255, 6203.96898015507, 6278.497720182374, 6316.589421687576, 6142.0383852415835, 6155.753769849245, 6169.01295792671, 6169.81490555284, 6174.938250617436, 6255.093011513396, 6263.404976527223, 6276.246850377984, 6282.277538083179, 6297.874042519124, 6074.179985701962, 6106.733702294202, 6129.387061293835, 6172.753089876444, 6184.350643182401, 6184.196054512884, 6194.039923811816, 6234.875302493925, 6244.469220116341, 6258.874822503615, 4927.827526036644, 4937.679050861682, 4938.160512712848, 4939.431965324034, 4952.504749525018, 4394.2969124939855, 4405.31717583775, 4405.713628614129, 4444.022315090675, 4454.821807127679, 5711.771529138788, 5754.4533269339345, 5763.904858077036, 5783.306003279633, 5831.562632802556, 6229.875402491924, 6267.341929097379, 6285.465735412541, 6290.150829638032, 6306.369363063749, 5601.60788744784, 5746.396628354046, 5749.223854779635, 5781.075027995501, 5782.10377391505, 5346.331708536433, 5348.598855085884, 5399.946000540023, 5411.512963833274, 5459.344878614512, 6298.527610429328, 6310.5898116622275, 6349.079383489368, 6352.61884286935, 6372.107904893412, 6253.96873015632, 6269.059641053878, 6273.686315684106, 6291.465225455888, 6292.4966002720585, 6186.969065154645, 6220.595661282002, 6237.282712488122, 6267.811965641038, 6325.841853953504, 6219.0, 6237.8752424950335, 6239.656818875005, 6244.438000579969, 6253.6560489173535, 4757.785899634594, 6276.811695649138, 6278.497720182466, 6284.24589049317, 6293.590916590407, 5983.581149319506, 6057.1519987200945, 6061.848453788691, 6110.541709371726, 6134.957077260823, 6100.066499260575, 6144.556029333193, 6145.709401025834, 6146.0, 6179.258488981351, 5955.166276721349, 6007.399260074132, 6008.609440386361, 6036.84907877289, 6040.546958978182, 6011.218541589566, 6074.574779765374, 6135.570510064253, 6144.4777193937225, 6148.50811935053, 5990.131430942576, 5991.610545314715, 5997.16039754426, 6005.429484199169, 6039.275286965592], "value": 5711.404868073316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.70020636483105, 469.8934010405495, 496.739211913745, 524.5881982643623, 528.772627770059, 29624.0, 38322.616773832255, 39313.0, 39467.60532394675, 41500.37749433753, 41155.58844411555, 41292.17415651685, 41338.0, 41397.79301103498, 41439.58560414395, 9306.534673266344, 9522.476263805487, 9700.708978730649, 9710.368826026286, 9721.659741909034, 7796.6491507882, 8705.390622656416, 8713.869291960626, 8787.95606021969, 8804.031556528776, 11632.0, 11882.346470944094, 11892.464839082262, 12118.757624847498, 12132.0, 11908.880911190907, 12002.579909703205, 12019.759604807854, 12042.397880106048, 12053.939730301336, 7315.780526584158, 8326.333893288584, 11510.194286399956, 11725.648230553097, 11733.4719937603, 31153.688463115304, 31573.368532629447, 38212.61787382118, 38709.22581548381, 38771.224575508335, 2966.7774916881103, 3224.9677503224902, 3280.4095262852675, 3574.8748793792092, 4037.735849056604, 29858.253543661584, 30049.399012019854, 30350.392992140256, 30526.84736576325, 30830.53754193689, 2858.799304292202, 3189.9043028709175, 3200.0399880035898, 3235.433799085174, 3323.570864528252, 621831.0, 632802.0, 633358.8332058357, 635668.0, 644461.1100278466, 58816.11775823366, 59446.51383715355, 59507.404925950184, 59553.40446595479, 59628.0, 52289.0, 60285.0957235633, 61095.694521528, 61413.69293153506, 62109.689451552455, 15846.76229856553, 15931.044137351795, 15937.36250549965, 15953.0, 16012.679746405007, 12219.389030548436, 12341.50633974649, 12355.0, 12357.443915023845, 12657.873421265853, 15624.531264061869, 15948.607708843534, 17863.106844657716, 18066.638667226583, 18199.181036853373, 7425.925740742631, 7487.625618719042, 7554.0, 7572.886406703904, 7588.734394296283, 816.9019717633922, 852.2883392367443, 885.2608072259735, 944.4663764972769, 997.6607953295915, 25533.361665958128, 27371.58942615862, 28177.71822281792, 28506.85746571254, 29942.35317057583, 1053.7787064716495, 1123.309164863603, 1130.2032067392634, 1134.0927258193412, 1156.7455159864817, 10651.520681569347, 15269.465568705042, 15291.464798731991, 15560.743692164799, 15563.299651515708, 650438.0, 655550.0, 657535.0, 659265.0, 659968.0, 55109.448905511235, 55715.721421392635, 55824.72087639617, 55891.720541397844, 55968.16047759287, 1330.3680751643085, 1337.9665508362368, 1361.2717196299932, 1364.126958746403, 1367.0635614604028, 23873.373928867462, 28525.42949140964, 29692.406151877272, 30091.548626771055, 30265.848670756506, 47503.57489275327, 47592.52407476019, 47709.284360733924, 47737.52262477331, 47837.76081119572, 553896.0, 556185.0, 556821.0, 560276.0, 560608.0, 24939.62590561107, 25994.35014124662, 26125.216243512725, 26162.345941351618, 26206.34484137912, 32273.677263227066, 38252.6174738249, 44017.77991110024, 46016.7699161502, 48030.03939921252, 37803.0, 37810.865674029825, 38365.84196011107, 38868.61131388763, 39430.802845985585, 37470.0, 37642.61216490529, 38227.80886095552, 38573.035674108374, 38939.80530097331, 36877.44683829691, 36968.81515592405, 37152.44271335878, 37630.059248519006, 37803.432948505244, 31966.328081260795, 32964.1758956028, 33472.330553389285, 33650.49524257089, 33689.494657579664, 21434.78565214328, 24753.62869556994, 24843.006279748606, 24876.253712388658, 25248.0], "value": 19758.639817921605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5759948857282, 378.76705825917054, 388.4154347706702, 402.0852560425031, 410.9732867363621, 14547.854521454783, 14794.926025369872, 15319.463818766346, 20776.89611551942, 21001.789982100174, 18870.528236794085, 20016.0, 20328.390148295573, 20384.898075509638, 20839.47901302468, 5866.354700982888, 5984.3417224105315, 6072.119542666311, 6079.996800527908, 6096.634201947875, 5886.9705651471895, 5952.7023648817385, 6072.757089716428, 6080.30076541199, 6093.634381937076, 4151.23202207591, 5735.512481439083, 6437.452816510602, 6724.184470193045, 6828.385445309921, 5694.0, 6658.56719313248, 6766.729330826761, 6768.69540870662, 6785.287544807798, 5865.413458654143, 5867.530597552228, 5869.706514674249, 5899.174115623816, 5901.763929442817, 24606.53934606543, 25491.23526294214, 25550.0, 25558.74441255582, 25793.484130317287, 2121.904514296845, 2413.793103448276, 2629.408383113803, 2755.2423083651956, 3122.2194451387154, 14490.058146220463, 15443.30505127272, 15701.293441795147, 15752.44866429681, 15817.367305307775, 1585.992070039654, 1657.4033347994712, 1873.4754268804757, 1878.539757759344, 1892.3755160796904, 111495.0, 114288.0, 114502.42748786286, 114514.0, 115197.0, 10082.19342452602, 10268.691939241835, 10395.220358473145, 10554.155667546578, 10798.78402431947, 13327.200367977952, 13358.666033349244, 13359.532416365575, 13388.464461421629, 13402.463901444027, 6473.838154046092, 8345.833083338299, 8359.331253499706, 8488.618012189467, 8489.787755306043, 8349.707760228363, 8380.790480237922, 8417.28453081495, 8563.058063612998, 8577.914220857836, 6252.187215661935, 6413.486921046305, 6423.710933008026, 6425.614463132227, 6556.737730490822, 1818.054611601986, 1858.5838410066858, 1859.0983373064053, 1863.69249073904, 1867.7011678131435, 727.316322656701, 878.7363790862715, 880.124276345028, 926.6200857648332, 933.7758937854866, 20837.791622083587, 21589.460263493223, 21789.564208715736, 21801.0, 21880.0, 837.6063250272363, 886.2201262888746, 949.3259785552335, 953.1659797677032, 1007.4106647611229, 10219.029192226726, 11257.324560526395, 11646.184767066225, 11653.475593598308, 11701.239419437708, 507011.65947931906, 528650.0, 534191.0, 534291.0, 535191.0, 82715.5864220687, 113074.0, 118339.0, 119419.0, 123935.76064239422, 895.7447127568612, 984.2372161574837, 1001.759577701361, 1032.6385764982197, 1040.0327695243495, 18686.53283667919, 19100.808991909904, 19226.711599325743, 19230.0, 19477.61044779125, 50512.73718157075, 51350.74324628353, 51633.7418312906, 51838.70403239798, 51867.740661296455, 60006.39993600008, 69224.0, 70883.64558177382, 71426.92859607215, 74082.0, 7529.698812047676, 7697.576633285223, 7775.339096176888, 7806.297433231037, 7883.2510911465615, 11939.52241910314, 12143.992482480584, 12211.938940305241, 12224.493978734516, 12324.876751232372, 9208.171264586219, 9400.529973501161, 10865.239433239598, 10903.127749780157, 11014.889851101387, 10709.196810239107, 10829.458527073772, 10967.725806854893, 11013.504392302206, 11233.831492527783, 11210.383428911487, 11290.048652806765, 11454.427278635869, 11549.826752598885, 11661.125415594033, 6532.9346706534225, 7924.9207507926485, 7928.286454219148, 7989.400794940287, 8170.428070035278, 10980.396078215776, 11006.724831879266, 11172.273802202832, 11182.832257516306, 11247.718807029889], "value": 9581.987278564788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.764591488319, 1549.2408719727334, 1738.3568079810464, 1856.8236017578324, 1906.2851430713474, 8375.41372103953, 8943.418677785947, 8948.776280592972, 8959.686410975617, 8960.865587016184, 7811.062672479296, 8025.879611805813, 8423.241908228258, 8635.52504612246, 8694.869576956351, 2206.922757703481, 2365.7042869641296, 2371.5731168389684, 2372.122314743547, 2372.5373552157334, 2335.754745751697, 2349.553584818879, 2378.2984019714227, 2380.8928598213033, 2384.3562238195677, 2352.8588284702973, 2365.27859003004, 2376.869272190029, 2378.8096952243777, 2382.3686723018413, 2328.557574060923, 2341.988290058556, 2346.753590872951, 2348.4128967758147, 2362.161432691387, 2329.6738456616085, 2336.707911511061, 2349.89425475854, 2351.165336305621, 2351.953380745569, 8749.562521873944, 8841.513716745576, 8880.467171969702, 8897.73306800797, 8902.109789021046, 4312.935305970413, 5293.947060529423, 5296.073187192264, 5298.284731561267, 5298.894022119574, 3565.3938830398893, 3589.10272431892, 3637.7089832813313, 3654.488371627974, 3686.447032945053, 1092.6995076354067, 1102.2614848051824, 1105.4748994227677, 1118.8433619293305, 1129.1080046763047, 11513.309201447857, 11576.826347604709, 11600.651980440685, 11613.419329033599, 11622.767544649145, 3887.475190849199, 4280.700350975402, 4467.061916997467, 4485.215087359699, 4812.278158276286, 9948.552315145836, 9952.253580981456, 9970.651027214013, 9971.252156088321, 9976.102150806462, 5340.759665815048, 5349.839504814861, 5351.545118664957, 5365.946340536622, 5372.167314066326, 4314.805833737427, 4421.624161946271, 4572.862814115582, 4729.597984171384, 4920.581750551171, 3838.481804956351, 3846.6345697158727, 3979.8408063677707, 3985.3822657488136, 4015.1768887378603, 1129.717570607348, 1242.19257482637, 1249.9875001250052, 1257.792464243408, 1275.6491964709778, 777.4208214879951, 850.6342272822621, 892.9642814287356, 900.6262401103469, 936.8735220745249, 5770.365259821417, 5857.09215071656, 5971.492423144082, 5998.760049597967, 6134.2332208473945, 777.6740657179496, 903.6069309850236, 905.2124651553191, 945.8061097475002, 1007.5818535307765, 3586.8206589670413, 3964.8215830287704, 3975.542812576533, 4087.570805065485, 4100.712950093465, 10425.322354046963, 10794.406307653155, 10796.760971708612, 10800.567977280978, 10803.621873234557, 10706.571737130427, 10729.517171727135, 10740.033396994308, 10748.408837513856, 10783.191260655482, 7727.961360193163, 8060.31487323584, 8070.2333278338465, 8100.068492123363, 8199.0, 5074.67014644047, 5364.275822763877, 5930.762769489172, 5961.970190149022, 6130.570860039755, 9516.381435206966, 9697.981711920147, 10043.849342260019, 10116.949415253172, 10143.28996970205, 9968.451735154636, 10307.330023548446, 10315.948420257851, 10319.690409287734, 10403.722827309373, 7383.630818459163, 7440.107187137578, 7508.474406791691, 7526.661300241392, 7666.8083297918, 8122.187781222067, 8218.0, 8227.161629237904, 8227.71203007892, 8232.464889782144, 6915.446764258747, 7163.140423149255, 7300.744473943387, 7389.002484664717, 7569.1295501018085, 7254.5647261164495, 7290.4896657233485, 7305.817354566178, 7348.0, 7465.477416580788, 6908.5509441886115, 6917.619530925847, 6989.1962424321855, 6992.0560724303605, 7003.26465721092, 4991.875203119951, 5032.949670503248, 5069.264956581349, 5076.162433198629, 5125.2568377585785, 4957.206846904478, 4974.602031837517, 5066.493350664904, 5240.240165175952, 5264.184051472028], "value": 4572.912821290381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.93666798306344, 310.2569346415335, 317.8347259425098, 323.4291475545661, 323.977321587489, 5363.9463605363935, 5421.969825733117, 5462.23528705981, 5476.644018138818, 5491.835244942658, 5430.8913821723545, 5469.206964990074, 5504.1285962772645, 5508.0, 5514.972425137878, 3357.8824741134126, 3411.982940085296, 3678.540182477177, 3956.4460975463458, 4146.191492658918, 3400.846961886721, 4157.565639854261, 4163.770992595406, 4173.102782901676, 4192.434021407117, 4089.9386509202386, 4111.985127287622, 4118.043929133668, 4123.711340206187, 4136.5449800522065, 3623.4564815277654, 3830.9042273943096, 3913.256481268564, 4102.651274641659, 4131.29767939448, 2998.61018067652, 3083.0, 3544.2202715402827, 3585.982070089659, 3643.198496330803, 4375.453068366454, 4848.9757551212015, 4894.926576101361, 5290.867728306823, 5314.229436731653, 4147.709660323779, 4636.4962920023145, 4685.906281874378, 4760.428748550196, 4830.830920917786, 5677.971610141964, 5749.626274292157, 5751.338596061465, 5779.88440231193, 5801.187833703285, 3731.365667836474, 4052.629211911036, 4053.6149065838995, 4056.4523789288364, 4084.6732261419015, 5102.591792656615, 5540.4763689985175, 5547.44525547446, 5954.338082079576, 6019.999999999956, 3897.2595206910596, 4063.0858056936954, 4073.735207211522, 4093.2222877653153, 4136.379543068564, 3504.0363899927215, 4126.328836821092, 4145.2124096421585, 4152.024274295538, 4165.66674666032, 4243.2998555238655, 4670.271999360259, 4787.898783279865, 4801.735904525215, 4821.807127714852, 4471.754053527087, 4760.0, 5028.76795185182, 5300.44345343741, 5802.982449126515, 1214.5627574073326, 1215.070471089617, 1369.5275130080106, 1398.6363545478248, 1430.4564265579222, 804.4409135650784, 860.1613426908714, 867.7873920889297, 873.9512584898021, 882.148726478951, 4600.470945841204, 5129.846104616868, 5328.49379308965, 5336.599755018389, 5465.59008074396, 5847.327557330961, 5867.559933004956, 5870.882582348415, 5932.3474417814, 5944.851378715567, 5077.568406685399, 5368.0, 5412.891742165213, 5414.269073675004, 5419.729013549307, 2795.692473827877, 2966.006387860091, 2972.885168061977, 3068.861901214451, 3119.844007799601, 5165.66423182492, 5705.74324155414, 6156.230471191101, 6177.444030037228, 6208.385819686914, 5125.69245845243, 5982.20631847262, 6043.365446628129, 6129.417705317987, 6167.0, 5106.6680665758095, 6012.789552365646, 6060.878782424327, 6075.453209211104, 6103.725332360054, 5544.506960614948, 5611.410801865745, 5789.102689083199, 5905.114232865105, 5931.110333450017, 5187.651210685173, 5281.894362112813, 5684.7157642118555, 5762.300121464262, 5806.187133801355, 5224.7126408047925, 6049.425304596057, 6065.512330409943, 6078.5441091919165, 6096.664683442454, 3691.6123806999876, 3848.9905496169167, 4008.518977722692, 4033.4756481657196, 4051.5745846685672, 4826.469088400203, 5746.13807928814, 5757.0, 5770.307563092456, 5849.022664588121, 4965.726885021359, 5644.491995720241, 5651.943480565142, 5699.971500142473, 5719.342275638189, 4972.8508144755715, 5041.1430056889685, 5166.3800343958965, 5615.691136987505, 5728.598998070095, 4470.485894122217, 5373.194020896896, 5552.639078459887, 5566.0, 5571.439996800902, 5374.919376209282, 5449.536789372948, 5579.2746942897165, 5613.354464236501, 5669.376368599368, 4824.6863953842885, 5492.780288788564, 5495.258140151029, 5520.972395137998, 5561.193626924154], "value": 4157.036391995577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.4939872801126, 719.507137610737, 751.9135299440566, 768.0936494935975, 774.8798936164894, 15190.0, 15863.524094277162, 15894.284757185926, 15910.52268431946, 15916.92041539792, 12017.459214335355, 14259.215743134124, 14406.711865762705, 14430.783538246935, 14869.776953345681, 659.6701649175412, 669.9448368819105, 729.8430837369964, 833.0212000898949, 884.8407286688393, 849.218718778725, 863.6156910174975, 863.9028433888989, 864.5245115186653, 865.926396256319, 924.0205382294755, 924.339097545255, 924.6347692661394, 927.7587827164919, 928.5774972387547, 704.7850405626282, 725.173302435219, 729.16510595368, 917.9632814687404, 921.9858156028349, 541.3774159716319, 678.8302924268933, 697.1808125452573, 699.3950233048428, 703.8205257659264, 14680.55958321252, 14705.411783528645, 14721.705565888622, 14722.631934201623, 14738.70522589553, 12839.358032098358, 13620.0, 13801.51694690691, 13899.235542045184, 14024.158550487004, 11484.71288217793, 12757.42591583381, 12839.29383883886, 13021.41403636829, 13492.797608035888, 4468.084042771224, 4476.239039363316, 4491.39366185564, 4687.835925742583, 4699.483056863743, 122056.0, 125084.0, 128287.35856320753, 131962.0, 133033.3348333252, 10940.835887461695, 10971.725706857393, 11013.724656883642, 11278.15413843965, 11315.717107072389, 21616.243431479823, 21831.235906743186, 21838.0, 21847.235346762787, 22192.778072219393, 7796.376289896794, 7868.567228802356, 8015.799605009922, 8020.157883422156, 8231.09457959624, 4411.426514553087, 4413.1394378095965, 4477.417935668407, 4489.6408287336935, 4585.977070114628, 3028.697130286954, 3461.2731326421736, 3627.5646922369483, 3637.836297366625, 3638.9992751992886, 615.5137441421227, 652.8008957268079, 659.9406053455212, 663.5852592129919, 667.8564108716649, 551.4650788734921, 578.3869098755333, 613.3314686991201, 617.4350469320611, 642.9292777794439, 7685.807854803675, 7940.888275641415, 8529.786755331166, 8964.8655270171, 9004.8649270261, 585.9003969325225, 611.8500967263049, 616.8642898562309, 621.3761304494161, 623.1960770605958, 4010.5387880393546, 4241.957580424218, 4252.958025283825, 4445.73325600465, 5185.196294574347, 158179.0, 158357.41642583656, 160256.0, 160409.0, 164291.3570864276, 90038.0, 132107.0, 133873.33063334815, 137470.0, 138622.0, 82871.0, 110361.0, 116125.0, 118046.63906721989, 118222.99999999828, 10093.293469457067, 10098.293119481566, 10162.847557286499, 10213.33613315132, 10233.590656373663, 59411.81176376535, 59552.40447595469, 64439.67780161069, 65308.0, 65953.0, 95970.0, 102310.48844755729, 102336.0, 102645.48677256567, 105981.47009264905, 13379.0, 13604.319784010562, 13889.583312500641, 14053.859461405254, 14066.015378923377, 14433.0, 14459.204743739196, 14543.0, 14616.0, 14984.47554335593, 13376.799348009983, 13587.388567514288, 13620.114692544952, 14295.785563216352, 14631.048981816148, 13425.26161061151, 13580.320983950565, 13872.375743091787, 14087.225202613954, 14370.425182992563, 13425.328733563478, 13475.595732128051, 13505.919526437665, 13527.985401095155, 13914.950894860405, 10975.780484390427, 11382.772344552897, 11423.657290281304, 11428.657140285804, 11949.342786146846, 11506.597269095542, 11555.42222888869, 11678.357690327113, 11787.233829801036, 11804.940975295069], "value": 7906.28438671296, "unit": "score"}], "name": "dromaeo_css", "value": 7387.400129294313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 164.0, 182.0, 115.0, 110.0, 113.0, 110.0, 111.0, 111.0, 111.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 126.0, 160.0, 109.0, 130.0, 128.0, 107.0, 160.0, 108.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 183.0, 184.0, 187.0, 178.0, 183.0, 183.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 77.0, 156.0, 82.0, 81.0, 80.0, 55.0, 146.0, 80.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 132.0, 71.0, 71.0, 83.0, 119.0, 68.0, 69.0, 119.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 83.0, 87.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 92.0, 92.0, 93.0, 91.0, 93.0, 92.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 86.0, 87.0, 85.0, 124.0, 133.0, 96.0, 85.0, 87.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 82.0, 76.0, 72.0, 71.0, 71.0, 69.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 85.0, 86.0, 86.0, 87.0, 84.0, 85.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 140.0, 143.0, 153.0, 130.0, 138.0, 140.0, 191.0, 152.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 169.0, 170.0, 169.0, 166.0, 172.0, 168.0, 167.0, 166.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1482.6000000000001, "alertThreshold": 2.0}]} 05:00:46 INFO - Return code: 0 05:00:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:00:46 INFO - # TBPL SUCCESS # 05:00:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:00:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:00:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:00:46 INFO - 2016-08-29 05:00:46.164 screenresolution[1854:10495] starting screenresolution argv=screenresolution get 05:00:46 INFO - 2016-08-29 05:00:46.166 screenresolution[1854:10495] Display 0: 1600x1200x32@60 05:00:46 INFO - 2016-08-29 05:00:46.172 screenresolution[1855:10498] starting screenresolution argv=screenresolution list 05:00:46 INFO - Available Modes on Display 0 05:00:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:00:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:00:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:00:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:00:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:00:46 INFO - Intel Iris: 05:00:46 INFO - Chipset Model: Intel Iris 05:00:46 INFO - Type: GPU 05:00:46 INFO - Bus: Built-In 05:00:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:00:46 INFO - Vendor: Intel (0x8086) 05:00:46 INFO - Device ID: 0x0a2e 05:00:46 INFO - Revision ID: 0x0009 05:00:46 INFO - Displays: 05:00:46 INFO - Display: 05:00:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:00:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:00:46 INFO - Display Serial Number: 1600x1200 60 05:00:46 INFO - Main Display: Yes 05:00:46 INFO - Mirror: Off 05:00:46 INFO - Online: Yes 05:00:46 INFO - Rotation: Supported 05:00:46 INFO - Return code: 0 05:00:46 INFO - Running post-action listener: _resource_record_post_action 05:00:46 INFO - [mozharness: 2016-08-29 12:00:46.407400Z] Finished run-tests step (success) 05:00:46 INFO - Running post-run listener: _resource_record_post_run 05:00:46 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31960064; Write bytes: 709738496; Read time: 199; Write time: 2039 05:00:46 INFO - TinderboxPrint: CPU usage
53.4% 05:00:46 INFO - TinderboxPrint: I/O read bytes / time
31,960,064 / 199 05:00:46 INFO - TinderboxPrint: I/O write bytes / time
709,738,496 / 2,039 05:00:46 INFO - TinderboxPrint: CPU idle
2,255.8 (46.6%) 05:00:46 INFO - TinderboxPrint: CPU system
967.9 (20.0%) 05:00:46 INFO - TinderboxPrint: CPU user
1,621.9 (33.5%) 05:00:46 INFO - TinderboxPrint: Swap in / out
434,282,496 / 0 05:00:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396634624; Write bytes: 391178240; Read time: 29835; Write time: 824 05:00:46 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 29961216; Write bytes: 299886592; Read time: 180; Write time: 1167 05:00:46 INFO - Running post-run listener: _upload_blobber_files 05:00:46 INFO - Blob upload gear active. 05:00:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:00:46 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 05:00:46 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:00:46 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:00:47 INFO - Traceback (most recent call last): 05:00:47 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 05:00:47 INFO - main() 05:00:47 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 05:00:47 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 05:00:47 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 05:00:47 INFO - return set(response.json().get('whitelist', [])) 05:00:47 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 05:00:47 INFO - return json.loads(self.text or self.content, **kwargs) 05:00:47 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 05:00:47 INFO - return _default_decoder.decode(s) 05:00:47 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 05:00:47 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 05:00:47 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 05:00:47 INFO - raise ValueError("No JSON object could be decoded") 05:00:47 INFO - ValueError: No JSON object could be decoded 05:00:47 ERROR - Return code: 1 05:00:47 INFO - Setting buildbot property blobber_files to {} 05:00:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:00:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:00:47 INFO - Contents: 05:00:47 INFO - blobber_files:{} 05:00:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:00:47 INFO - Copying logs to upload dir... 05:00:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:00:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.456986 ========= master_lag: 0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-29 05:00:47.832009) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 05:00:47.835721) ========= 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.N4KVgey520/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.RQFWjf0dGG/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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:{} build_url:https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010765 build_url: 'https://queue.taskcluster.net/v1/task/VT2I7ldnQSKBVMMbxxafdg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 05:00:47.994886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-08-29 05:00:47.995225) ========= 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.N4KVgey520/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.RQFWjf0dGG/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005134 ========= master_lag: 4.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-08-29 05:00:52.592690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 05:00:52.593004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 05:00:52.890164) ========= ========= Total master_lag: 5.28 =========