builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0074 starttime: 1484326973.6 results: success (0) buildid: 20170113073116 builduid: b0e6c71cccd5421d8f9e3c05271dd03c revision: 2dad5748892eea01c320091ec83f274c0a3c9eb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.601386) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.601878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.602169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.631421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.631793) ========= 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.y3opqosfTf/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.tF4MOXVArC/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-13 09:02:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 197M=0s 2017-01-13 09:02:53 (197 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.786371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.786710) ========= 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.y3opqosfTf/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.tF4MOXVArC/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.026989 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.835208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:53.835571) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 2dad5748892eea01c320091ec83f274c0a3c9eb3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 2dad5748892eea01c320091ec83f274c0a3c9eb3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y3opqosfTf/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.tF4MOXVArC/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-13 09:02:53,932 truncating revision to first 12 chars 2017-01-13 09:02:53,932 Setting DEBUG logging. 2017-01-13 09:02:53,932 attempt 1/10 2017-01-13 09:02:53,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/2dad5748892e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 09:02:54,241 unpacking tar archive at: graphics-2dad5748892e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577480 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:54.439445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:54.439832) ========= script_repo_revision: 2dad5748892eea01c320091ec83f274c0a3c9eb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:54.440258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:54.440571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 09:02:54.461447) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-13 09:02:54.461838) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y3opqosfTf/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.tF4MOXVArC/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:02:54 INFO - MultiFileLogger online at 20170113 09:02:54 in /builds/slave/test 09:02:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 09:02:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:02:54 INFO - {'append_to_log': False, 09:02:54 INFO - 'base_work_dir': '/builds/slave/test', 09:02:54 INFO - 'blob_upload_branch': 'Graphics', 09:02:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:02:54 INFO - 'branch': 'Graphics', 09:02:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:54 INFO - 'config_files': ('talos/mac_config.py',), 09:02:54 INFO - 'default_actions': ('clobber', 09:02:54 INFO - 'read-buildbot-config', 09:02:54 INFO - 'download-and-extract', 09:02:54 INFO - 'populate-webroot', 09:02:54 INFO - 'create-virtualenv', 09:02:54 INFO - 'install', 09:02:54 INFO - 'run-tests'), 09:02:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:54 INFO - 'download_minidump_stackwalk': True, 09:02:54 INFO - 'download_symbols': 'ondemand', 09:02:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:54 INFO - 'installer_path': 'installer.exe', 09:02:54 INFO - 'log_level': 'info', 09:02:54 INFO - 'log_name': 'talos', 09:02:54 INFO - 'log_to_console': True, 09:02:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:02:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:02:54 INFO - 'opt_config_files': (), 09:02:54 INFO - 'pip_index': False, 09:02:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:02:54 INFO - 'cmd': ('bash', 09:02:54 INFO - '-c', 09:02:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:02:54 INFO - 'enabled': True, 09:02:54 INFO - 'halt_on_failure': False, 09:02:54 INFO - 'name': 'check_screen_resolution'},), 09:02:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:02:54 INFO - 'cmd': ('bash', 09:02:54 INFO - '-c', 09:02:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:02:54 INFO - 'enabled': True, 09:02:54 INFO - 'halt_on_failure': False, 09:02:54 INFO - 'name': 'check_screen_resolution'},), 09:02:54 INFO - 'run_cmd_checks_enabled': True, 09:02:54 INFO - 'sps_profile': False, 09:02:54 INFO - 'sps_profile_interval': 0, 09:02:54 INFO - 'suite': 'dromaeojs', 09:02:54 INFO - 'system_bits': '32', 09:02:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:54 INFO - 'title': 't-yosemite-r7-0074', 09:02:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:54 INFO - 'use_talos_json': True, 09:02:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:02:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:54 INFO - 'work_dir': 'build'} 09:02:54 INFO - [mozharness: 2017-01-13 17:02:54.671164Z] Running clobber step. 09:02:54 INFO - Running pre-action listener: _resource_record_pre_action 09:02:54 INFO - Running main action method: clobber 09:02:54 INFO - rmtree: /builds/slave/test/build 09:02:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:02:57 INFO - Running post-action listener: _resource_record_post_action 09:02:57 INFO - [mozharness: 2017-01-13 17:02:57.017740Z] Finished clobber step (success) 09:02:57 INFO - [mozharness: 2017-01-13 17:02:57.017861Z] Running read-buildbot-config step. 09:02:57 INFO - Running pre-action listener: _resource_record_pre_action 09:02:57 INFO - Running main action method: read_buildbot_config 09:02:57 INFO - Using buildbot properties: 09:02:57 INFO - { 09:02:57 INFO - "project": "", 09:02:57 INFO - "product": "firefox", 09:02:57 INFO - "script_repo_revision": "default", 09:02:57 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 09:02:57 INFO - "repository": "", 09:02:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 09:02:57 INFO - "buildid": "20170113073116", 09:02:57 INFO - "pgo_build": "False", 09:02:57 INFO - "basedir": "/builds/slave/test", 09:02:57 INFO - "buildnumber": 4, 09:02:57 INFO - "slavename": "t-yosemite-r7-0074", 09:02:57 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:02:57 INFO - "platform": "yosemite_r7", 09:02:57 INFO - "scheduler": "tests-graphics-macosx64-talos", 09:02:57 INFO - "branch": "graphics", 09:02:57 INFO - "repo_path": "projects/graphics", 09:02:57 INFO - "revision": "2dad5748892eea01c320091ec83f274c0a3c9eb3", 09:02:57 INFO - "stage_platform": "macosx64", 09:02:57 INFO - "builduid": "b0e6c71cccd5421d8f9e3c05271dd03c", 09:02:57 INFO - "slavebuilddir": "test" 09:02:57 INFO - } 09:02:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:02:57 INFO - Running post-action listener: _resource_record_post_action 09:02:57 INFO - [mozharness: 2017-01-13 17:02:57.021168Z] Finished read-buildbot-config step (success) 09:02:57 INFO - [mozharness: 2017-01-13 17:02:57.021285Z] Running download-and-extract step. 09:02:57 INFO - Running pre-action listener: _resource_record_pre_action 09:02:57 INFO - Running main action method: download_and_extract 09:02:57 INFO - mkdir: /builds/slave/test/build/tests 09:02:57 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')]} 09:02:57 INFO - trying https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:02:57 INFO - Downloading https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:02:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 09:02:58 INFO - Downloaded 1199 bytes. 09:02:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:02:58 INFO - Using the following test package requirements: 09:02:58 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:02:58 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:02:58 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:02:58 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'jsshell-mac.zip'], 09:02:58 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:02:58 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:02:58 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:02:58 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:02:58 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:02:58 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:02:58 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:02:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:02:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:02:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:02:58 INFO - Fetch https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:02:59 INFO - Expected file size: 16314238 09:02:59 INFO - Obtained file size: 16314238 09:03:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:03:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:03:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:03:06 INFO - Fetch https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:03:06 INFO - Expected file size: 16314238 09:03:06 INFO - Obtained file size: 16314238 09:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:03:14 INFO - Expected file size: 14403532 09:03:14 INFO - Obtained file size: 14403532 09:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:14 INFO - trying https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:03:14 INFO - Downloading https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:03:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 09:03:17 INFO - Downloaded 70114455 bytes. 09:03:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:03:17 INFO - mkdir: /builds/slave/test/properties 09:03:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:17 INFO - Contents: 09:03:17 INFO - build_url:https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:03:17 INFO - Running post-action listener: _resource_record_post_action 09:03:17 INFO - Running post-action listener: set_extra_try_arguments 09:03:17 INFO - [mozharness: 2017-01-13 17:03:17.734477Z] Finished download-and-extract step (success) 09:03:17 INFO - [mozharness: 2017-01-13 17:03:17.734594Z] Running populate-webroot step. 09:03:17 INFO - Running pre-action listener: _resource_record_pre_action 09:03:17 INFO - Running main action method: populate_webroot 09:03:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:17 INFO - '--tppagecycles', 09:03:17 INFO - '7'], 09:03:17 INFO - 'tests': ['tsvgm']}}, 09:03:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['damp', 'tps']}, 09:03:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'tests': ['damp', 'tps']}, 09:03:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['dromaeo_dom']}, 09:03:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['basic_compositor_video']}, 09:03:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:03:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['a11yr', 09:03:17 INFO - 'ts_paint', 09:03:17 INFO - 'tpaint', 09:03:17 INFO - 'sessionrestore', 09:03:17 INFO - 'sessionrestore_no_auto_restore', 09:03:17 INFO - 'tabpaint']}, 09:03:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:17 INFO - 'ts_paint', 09:03:17 INFO - 'tpaint', 09:03:17 INFO - 'sessionrestore', 09:03:17 INFO - 'sessionrestore_no_auto_restore', 09:03:17 INFO - 'tabpaint']}, 09:03:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:17 INFO - 'ts_paint', 09:03:17 INFO - 'tpaint', 09:03:17 INFO - 'sessionrestore', 09:03:17 INFO - 'sessionrestore_no_auto_restore', 09:03:17 INFO - 'tabpaint']}, 09:03:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:17 INFO - 'ts_paint', 09:03:17 INFO - 'tpaint', 09:03:17 INFO - 'sessionrestore', 09:03:17 INFO - 'sessionrestore_no_auto_restore', 09:03:17 INFO - 'tabpaint']}, 09:03:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['a11yr', 09:03:17 INFO - 'ts_paint', 09:03:17 INFO - 'tpaint', 09:03:17 INFO - 'sessionrestore', 09:03:17 INFO - 'sessionrestore_no_auto_restore', 09:03:17 INFO - 'tabpaint']}, 09:03:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['a11yr', 09:03:17 INFO - 'ts_paint', 09:03:17 INFO - 'tpaint', 09:03:17 INFO - 'sessionrestore', 09:03:17 INFO - 'sessionrestore_no_auto_restore', 09:03:17 INFO - 'tabpaint']}, 09:03:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['tsvgx', 09:03:17 INFO - 'tsvgr_opacity', 09:03:17 INFO - 'tart', 09:03:17 INFO - 'tscrollx', 09:03:17 INFO - 'cart', 09:03:17 INFO - 'tsvg_static']}, 09:03:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:17 INFO - 'tsvgr_opacity', 09:03:17 INFO - 'tart', 09:03:17 INFO - 'tscrollx', 09:03:17 INFO - 'cart', 09:03:17 INFO - 'tsvg_static']}, 09:03:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'talos_options': ['--disable-e10s'], 09:03:17 INFO - 'tests': ['tp5o']}, 09:03:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:03:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'talos_options': ['--disable-e10s', 09:03:17 INFO - '--xperf_path', 09:03:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:17 INFO - 'tests': ['tp5n']}, 09:03:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:03:17 INFO - 'talos_options': ['--xperf_path', 09:03:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:17 INFO - 'tests': ['tp5n']}}, 09:03:17 INFO - 'talos.zip': {'path': '', 09:03:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:17 INFO - Running post-action listener: _resource_record_post_action 09:03:17 INFO - [mozharness: 2017-01-13 17:03:17.752875Z] Finished populate-webroot step (success) 09:03:17 INFO - [mozharness: 2017-01-13 17:03:17.753009Z] Running create-virtualenv step. 09:03:17 INFO - Running pre-action listener: _resource_record_pre_action 09:03:17 INFO - Running main action method: create_virtualenv 09:03:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:17 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 09:03:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:17 INFO - Using real prefix '/tools/python27' 09:03:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:21 INFO - Installing pip.................done. 09:03:21 INFO - Return code: 0 09:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:21 INFO - Reading from file tmpfile_stdout 09:03:21 INFO - Output received: 09:03:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:03:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:21 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:21 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 09:03:21 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 09:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:21 INFO - 'HOME': '/Users/cltbld', 09:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:21 INFO - 'LOGNAME': 'cltbld', 09:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:21 INFO - 'MOZ_NO_REMOTE': '1', 09:03:21 INFO - 'NO_EM_RESTART': '1', 09:03:21 INFO - 'PAGER': '/bin/cat', 09:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:21 INFO - 'PWD': '/builds/slave/test', 09:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:21 INFO - 'SHELL': '/bin/bash', 09:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:21 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:21 INFO - 'USER': 'cltbld', 09:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:21 INFO - 'XPC_FLAGS': '0x0', 09:03:21 INFO - 'XPC_SERVICE_NAME': '0', 09:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:21 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 09:03:21 INFO - Cleaning up... 09:03:21 INFO - Return code: 0 09:03:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:21 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:21 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 09:03:21 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 09:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:21 INFO - 'HOME': '/Users/cltbld', 09:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:21 INFO - 'LOGNAME': 'cltbld', 09:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:21 INFO - 'MOZ_NO_REMOTE': '1', 09:03:21 INFO - 'NO_EM_RESTART': '1', 09:03:21 INFO - 'PAGER': '/bin/cat', 09:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:21 INFO - 'PWD': '/builds/slave/test', 09:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:21 INFO - 'SHELL': '/bin/bash', 09:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:21 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:21 INFO - 'USER': 'cltbld', 09:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:21 INFO - 'XPC_FLAGS': '0x0', 09:03:21 INFO - 'XPC_SERVICE_NAME': '0', 09:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:22 INFO - Downloading/unpacking psutil>=3.1.1 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03: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 09:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:25 INFO - Installing collected packages: psutil 09:03:25 INFO - Running setup.py install for psutil 09:03:25 INFO - building 'psutil._psutil_osx' extension 09:03:25 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 09:03:26 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 09:03:26 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 09:03:26 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 09:03:26 INFO - building 'psutil._psutil_posix' extension 09:03:26 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 09:03:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:03:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:03:26 INFO - ^ 09:03:26 INFO - 1 warning generated. 09:03:26 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 09:03:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:26 INFO - Successfully installed psutil 09:03:26 INFO - Cleaning up... 09:03:27 INFO - Return code: 0 09:03:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:27 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')]} 09:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:27 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')]} 09:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:27 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:27 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 09:03:27 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 09:03:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:27 INFO - 'HOME': '/Users/cltbld', 09:03:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:27 INFO - 'LOGNAME': 'cltbld', 09:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:27 INFO - 'MOZ_NO_REMOTE': '1', 09:03:27 INFO - 'NO_EM_RESTART': '1', 09:03:27 INFO - 'PAGER': '/bin/cat', 09:03:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:27 INFO - 'PWD': '/builds/slave/test', 09:03:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:27 INFO - 'SHELL': '/bin/bash', 09:03:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:27 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:27 INFO - 'USER': 'cltbld', 09:03:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:27 INFO - 'XPC_FLAGS': '0x0', 09:03:27 INFO - 'XPC_SERVICE_NAME': '0', 09:03:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:27 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 09:03:27 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 09:03:27 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 09:03:27 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 09:03:27 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 09:03:27 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 09:03:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:30 INFO - Installing collected packages: mozsystemmonitor 09:03:30 INFO - Running setup.py install for mozsystemmonitor 09:03:30 INFO - Successfully installed mozsystemmonitor 09:03:30 INFO - Cleaning up... 09:03:30 INFO - Return code: 0 09:03:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:30 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')]} 09:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:30 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')]} 09:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:30 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:30 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 09:03:30 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 09:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:30 INFO - 'HOME': '/Users/cltbld', 09:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:30 INFO - 'LOGNAME': 'cltbld', 09:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:30 INFO - 'MOZ_NO_REMOTE': '1', 09:03:30 INFO - 'NO_EM_RESTART': '1', 09:03:30 INFO - 'PAGER': '/bin/cat', 09:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:30 INFO - 'PWD': '/builds/slave/test', 09:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:30 INFO - 'SHELL': '/bin/bash', 09:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:30 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:30 INFO - 'USER': 'cltbld', 09:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:30 INFO - 'XPC_FLAGS': '0x0', 09:03:30 INFO - 'XPC_SERVICE_NAME': '0', 09:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:30 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:30 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 09:03:30 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 09:03:30 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 09:03:30 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 09:03:30 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 09:03:30 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 09:03:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:33 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 09:03:33 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 09:03:33 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 09:03:33 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 09:03:33 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 09:03:33 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 09:03:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:33 INFO - warning: no files found matching '*.txt' 09:03:33 INFO - no previously-included directories found matching 'build' 09:03:33 INFO - no previously-included directories found matching 'dist' 09:03:33 INFO - no previously-included directories found matching '.git*' 09:03:33 INFO - Installing collected packages: jsonschema, functools32 09:03:33 INFO - Running setup.py install for functools32 09:03:33 INFO - warning: no files found matching '*.txt' 09:03:33 INFO - no previously-included directories found matching 'build' 09:03:33 INFO - no previously-included directories found matching 'dist' 09:03:33 INFO - no previously-included directories found matching '.git*' 09:03:33 INFO - Successfully installed jsonschema functools32 09:03:33 INFO - Cleaning up... 09:03:33 INFO - Return code: 0 09:03:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03:33 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')]} 09:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:33 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')]} 09:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:33 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:33 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 09:03:33 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 09:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:33 INFO - 'HOME': '/Users/cltbld', 09:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:33 INFO - 'LOGNAME': 'cltbld', 09:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:33 INFO - 'MOZ_NO_REMOTE': '1', 09:03:33 INFO - 'NO_EM_RESTART': '1', 09:03:33 INFO - 'PAGER': '/bin/cat', 09:03:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:33 INFO - 'PWD': '/builds/slave/test', 09:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:33 INFO - 'SHELL': '/bin/bash', 09:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:33 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:33 INFO - 'USER': 'cltbld', 09:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:33 INFO - 'XPC_FLAGS': '0x0', 09:03:33 INFO - 'XPC_SERVICE_NAME': '0', 09:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:34 INFO - Cleaning up... 09:03:34 INFO - Return code: 0 09:03:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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', '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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:03: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 blobuploader==1.2.4 09:03:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:34 INFO - 'HOME': '/Users/cltbld', 09:03:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:34 INFO - 'LOGNAME': 'cltbld', 09:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:34 INFO - 'MOZ_NO_REMOTE': '1', 09:03:34 INFO - 'NO_EM_RESTART': '1', 09:03:34 INFO - 'PAGER': '/bin/cat', 09:03:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:34 INFO - 'PWD': '/builds/slave/test', 09:03:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:34 INFO - 'SHELL': '/bin/bash', 09:03:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:34 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:34 INFO - 'USER': 'cltbld', 09:03:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:34 INFO - 'XPC_FLAGS': '0x0', 09:03:34 INFO - 'XPC_SERVICE_NAME': '0', 09:03:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:34 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 09:03:34 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 09:03:34 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 09:03:34 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 09:03:34 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 09:03:34 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 09:03:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 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 09:03:37 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 09:03:38 INFO - Downloading docopt-0.6.1.tar.gz 09:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:38 INFO - Running setup.py install for blobuploader 09:03:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:38 INFO - Running setup.py install for requests 09:03:39 INFO - Running setup.py install for docopt 09:03:39 INFO - Successfully installed blobuploader requests docopt 09:03:39 INFO - Cleaning up... 09:03:39 INFO - Return code: 0 09:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:39 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')]} 09:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:39 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')]} 09:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:39 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:39 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 09:03:39 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 09:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:39 INFO - 'HOME': '/Users/cltbld', 09:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:39 INFO - 'LOGNAME': 'cltbld', 09:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:39 INFO - 'MOZ_NO_REMOTE': '1', 09:03:39 INFO - 'NO_EM_RESTART': '1', 09:03:39 INFO - 'PAGER': '/bin/cat', 09:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:39 INFO - 'PWD': '/builds/slave/test', 09:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:39 INFO - 'SHELL': '/bin/bash', 09:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:39 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:39 INFO - 'USER': 'cltbld', 09:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:39 INFO - 'XPC_FLAGS': '0x0', 09:03:39 INFO - 'XPC_SERVICE_NAME': '0', 09:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-wTshPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-f4vGyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:39 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-4zLMmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XLzT9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-5rV1lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8p_Xro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-hb7ci3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-4vSVKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-wgkYmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-pzQW5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-u8MwuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-W1llXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:40 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-mkaPxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:41 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-9J4z4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:41 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Y4LsB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:41 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-lvA4aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:41 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XSY1HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:41 INFO - Running setup.py install for manifestparser 09:03:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:41 INFO - Running setup.py install for mozcrash 09:03:41 INFO - Running setup.py install for mozdebug 09:03:41 INFO - Running setup.py install for mozdevice 09:03:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Running setup.py install for mozfile 09:03:42 INFO - Running setup.py install for mozhttpd 09:03:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Running setup.py install for mozinfo 09:03:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Running setup.py install for mozInstall 09:03:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Running setup.py install for mozleak 09:03:42 INFO - Running setup.py install for mozlog 09:03:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:42 INFO - Running setup.py install for moznetwork 09:03:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:43 INFO - Running setup.py install for mozprocess 09:03:43 INFO - Running setup.py install for mozprofile 09:03:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:43 INFO - Running setup.py install for mozrunner 09:03:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:43 INFO - Running setup.py install for mozscreenshot 09:03:43 INFO - Running setup.py install for moztest 09:03:43 INFO - Running setup.py install for mozversion 09:03:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:44 INFO - Cleaning up... 09:03:44 INFO - Return code: 0 09:03:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:44 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')]} 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:44 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')]} 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:44 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:44 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 09:03:44 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 09:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:44 INFO - 'HOME': '/Users/cltbld', 09:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:44 INFO - 'LOGNAME': 'cltbld', 09:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:44 INFO - 'MOZ_NO_REMOTE': '1', 09:03:44 INFO - 'NO_EM_RESTART': '1', 09:03:44 INFO - 'PAGER': '/bin/cat', 09:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:44 INFO - 'PWD': '/builds/slave/test', 09:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:44 INFO - 'SHELL': '/bin/bash', 09:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:44 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:44 INFO - 'USER': 'cltbld', 09:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:44 INFO - 'XPC_FLAGS': '0x0', 09:03:44 INFO - 'XPC_SERVICE_NAME': '0', 09:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-umBxTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:44 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)) 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-LOBKtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-BbRqQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:44 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)) 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-oeLZdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-TRiMaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:44 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)) 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-cZhGqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:44 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)) 09:03:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:44 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-jytCdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:45 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)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-qIZLwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:45 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)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-rLt3o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:45 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)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-FOecrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-yVW0YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:45 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)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-IK1xOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ir0pj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:45 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)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-uaawxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Reb0Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:45 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)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-DIXEkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:03:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:45 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-TzzuRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:46 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)) 09:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:03:46 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)) 09:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:03:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:48 INFO - Downloading blessings-1.6.tar.gz 09:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:48 INFO - Installing collected packages: blessings 09:03:48 INFO - Running setup.py install for blessings 09:03:49 INFO - Successfully installed blessings 09:03:49 INFO - Cleaning up... 09:03:49 INFO - Return code: 0 09:03:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:49 INFO - Reading from file tmpfile_stdout 09:03:49 INFO - Current package versions: 09:03:49 INFO - blessings == 1.6 09:03:49 INFO - blobuploader == 1.2.4 09:03:49 INFO - docopt == 0.6.1 09:03:49 INFO - functools32 == 3.2.3-2 09:03:49 INFO - jsonschema == 2.5.1 09:03:49 INFO - manifestparser == 1.1 09:03:49 INFO - mozInstall == 1.12 09:03:49 INFO - mozcrash == 1.0 09:03:49 INFO - mozdebug == 0.1 09:03:49 INFO - mozdevice == 0.49 09:03:49 INFO - mozfile == 1.2 09:03:49 INFO - mozhttpd == 0.7 09:03:49 INFO - mozinfo == 0.9 09:03:49 INFO - mozleak == 0.1 09:03:49 INFO - mozlog == 3.4 09:03:49 INFO - moznetwork == 0.27 09:03:49 INFO - mozprocess == 0.24 09:03:49 INFO - mozprofile == 0.28 09:03:49 INFO - mozrunner == 6.13 09:03:49 INFO - mozscreenshot == 0.1 09:03:49 INFO - mozsystemmonitor == 0.3 09:03:49 INFO - moztest == 0.8 09:03:49 INFO - mozversion == 1.4 09:03:49 INFO - psutil == 3.1.1 09:03:49 INFO - requests == 1.2.3 09:03:49 INFO - wsgiref == 0.1.2 09:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:50 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:50 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 09:03:50 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 09:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:50 INFO - 'HOME': '/Users/cltbld', 09:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:50 INFO - 'LOGNAME': 'cltbld', 09:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:50 INFO - 'MOZ_NO_REMOTE': '1', 09:03:50 INFO - 'NO_EM_RESTART': '1', 09:03:50 INFO - 'PAGER': '/bin/cat', 09:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:50 INFO - 'PWD': '/builds/slave/test', 09:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:50 INFO - 'SHELL': '/bin/bash', 09:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:50 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:50 INFO - 'USER': 'cltbld', 09:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:50 INFO - 'XPC_FLAGS': '0x0', 09:03:50 INFO - 'XPC_SERVICE_NAME': '0', 09:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 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)) 09:03:50 INFO - Cleaning up... 09:03:50 INFO - Return code: 0 09:03:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:51 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 0x103228b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10322b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb4ad5cd70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, '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.y3opqosfTf/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.tF4MOXVArC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 09:03:51 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 09:03:51 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 09:03:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:03:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:51 INFO - 'HOME': '/Users/cltbld', 09:03:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:51 INFO - 'LOGNAME': 'cltbld', 09:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:51 INFO - 'MOZ_NO_REMOTE': '1', 09:03:51 INFO - 'NO_EM_RESTART': '1', 09:03:51 INFO - 'PAGER': '/bin/cat', 09:03:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:51 INFO - 'PWD': '/builds/slave/test', 09:03:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:51 INFO - 'SHELL': '/bin/bash', 09:03:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:03:51 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:03:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:51 INFO - 'USER': 'cltbld', 09:03:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:51 INFO - 'XPC_FLAGS': '0x0', 09:03:51 INFO - 'XPC_SERVICE_NAME': '0', 09:03:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:51 INFO - Cleaning up... 09:03:51 INFO - Return code: 0 09:03:51 INFO - Running post-action listener: _resource_record_post_action 09:03:51 INFO - Running post-action listener: _start_resource_monitoring 09:03:51 INFO - Starting resource monitoring. 09:03:51 INFO - [mozharness: 2017-01-13 17:03:51.440428Z] Finished create-virtualenv step (success) 09:03:51 INFO - [mozharness: 2017-01-13 17:03:51.441370Z] Running install step. 09:03:51 INFO - Running pre-action listener: _resource_record_pre_action 09:03:51 INFO - Running main action method: install 09:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:51 INFO - Reading from file tmpfile_stdout 09:03:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:51 INFO - Reading from file tmpfile_stdout 09:03:51 INFO - Output received: 09:03:51 INFO - Usage: mozinstall [options] installer 09:03:51 INFO - Options: 09:03:51 INFO - -h, --help show this help message and exit 09:03:51 INFO - -d DEST, --destination=DEST 09:03:51 INFO - Directory to install application into. [default: 09:03:51 INFO - "/builds/slave/test"] 09:03:51 INFO - --app=APP Application being installed. [default: firefox] 09:03:51 INFO - mkdir: /builds/slave/test/build/application 09:03:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:04:13 INFO - Reading from file tmpfile_stdout 09:04:13 INFO - Output received: 09:04:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:04:13 INFO - Running post-action listener: _resource_record_post_action 09:04:13 INFO - [mozharness: 2017-01-13 17:04:13.490773Z] Finished install step (success) 09:04:13 INFO - [mozharness: 2017-01-13 17:04:13.490918Z] Running run-tests step. 09:04:13 INFO - Running pre-action listener: _resource_record_pre_action 09:04:13 INFO - Running main action method: run_tests 09:04:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:04:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:04:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:04:13 INFO - 2017-01-13 09:04:13.503 screenresolution[1618:7531] starting screenresolution argv=screenresolution get 09:04:13 INFO - 2017-01-13 09:04:13.506 screenresolution[1618:7531] Display 0: 1600x1200x32@60 09:04:13 INFO - 2017-01-13 09:04:13.511 screenresolution[1619:7533] starting screenresolution argv=screenresolution list 09:04:13 INFO - Available Modes on Display 0 09:04:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:04:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:04:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:04:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:04:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:04:13 INFO - Intel Iris: 09:04:13 INFO - Chipset Model: Intel Iris 09:04:13 INFO - Type: GPU 09:04:13 INFO - Bus: Built-In 09:04:13 INFO - VRAM (Dynamic, Max): 1536 MB 09:04:13 INFO - Vendor: Intel (0x8086) 09:04:13 INFO - Device ID: 0x0a2e 09:04:13 INFO - Revision ID: 0x0009 09:04:13 INFO - Displays: 09:04:13 INFO - Display: 09:04:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:04:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:04:13 INFO - Display Serial Number: 1600x1200 60 09:04:13 INFO - Main Display: Yes 09:04:13 INFO - Mirror: Off 09:04:13 INFO - Online: Yes 09:04:13 INFO - Rotation: Supported 09:04:13 INFO - Return code: 0 09:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:13 INFO - Python 2.7.3 09:04:13 INFO - Return code: 0 09:04:13 INFO - grabbing minidump binary from tooltool 09:04: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')]} 09:04:13 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 0x103006d30>, '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 0x102f2ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ffbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:13 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 09:04:13 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 09:04:13 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 09:04:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:13 INFO - Return code: 0 09:04:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:04:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:04:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 09:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --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 09:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y3opqosfTf/Render', 09:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:04:13 INFO - 'HOME': '/Users/cltbld', 09:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:04:13 INFO - 'LOGNAME': 'cltbld', 09:04:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:13 INFO - 'MOZ_NO_REMOTE': '1', 09:04:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:13 INFO - 'NO_EM_RESTART': '1', 09:04:13 INFO - 'PAGER': '/bin/cat', 09:04:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:13 INFO - 'PWD': '/builds/slave/test', 09:04:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:04:13 INFO - 'SHELL': '/bin/bash', 09:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tF4MOXVArC/Listeners', 09:04:13 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 09:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:04:13 INFO - 'USER': 'cltbld', 09:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:13 INFO - 'XPC_FLAGS': '0x0', 09:04:13 INFO - 'XPC_SERVICE_NAME': '0', 09:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:04:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 09:04:14 INFO - mozversion application_buildid: 20170113073116 09:04:14 INFO - mozversion application_changeset: 2dad5748892eea01c320091ec83f274c0a3c9eb3 09:04:14 INFO - mozversion application_display_name: Nightly 09:04:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:14 INFO - mozversion application_name: Firefox 09:04:14 INFO - mozversion application_remotingname: firefox 09:04:14 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:04:14 INFO - mozversion application_vendor: Mozilla 09:04:14 INFO - mozversion application_version: 53.0a1 09:04:14 INFO - mozversion platform_buildid: 20170113073116 09:04:14 INFO - mozversion platform_changeset: 2dad5748892eea01c320091ec83f274c0a3c9eb3 09:04:14 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:04:14 INFO - mozversion platform_version: 53.0a1 09:04:14 INFO - using testdate: 1484327054 09:04:14 INFO - actual date: 1484327054 09:04:14 INFO - starting webserver on 'localhost:49241' 09:04:14 INFO - SUITE-START | Running 2 tests 09:04:14 INFO - TEST-START | dromaeo_css 09:04:14 INFO - operating with platform_type : mac_ 09:04:14 INFO - Initialising browser for dromaeo_css test... 09:04:14 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpGEp6f9/profile http://localhost:49241/getInfo.html) 09:04:16 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 09:04:16 INFO - PROCESS | 1629 | colorDepth:24 09:04:16 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 09:04:16 INFO - PROCESS | 1629 | __metrics 09:04:16 INFO - PROCESS | 1629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:04:16 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:17 INFO - TEST-INFO | 1629: exit 0 09:04:17 INFO - Browser initialized. 09:04:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:17 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpGEp6f9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:29 INFO - PROCESS | 1631 | RSS: Main: 234913792 09:04:29 INFO - PROCESS | 1631 | 09:07:33 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:07:35 INFO - PROCESS | 1631 | RSS: Main: 427978752 09:07:35 INFO - PROCESS | 1631 | 09:09:18 INFO - PROCESS | 1631 | ************************* 09:09:18 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 09:09:18 INFO - PROCESS | 1631 | 09:09:18 INFO - PROCESS | 1631 | Full message: ReferenceError: fetch is not defined 09:09:18 INFO - PROCESS | 1631 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 09:09:18 INFO - PROCESS | 1631 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 09:09:18 INFO - PROCESS | 1631 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 09:09:18 INFO - PROCESS | 1631 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:09:18 INFO - PROCESS | 1631 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:09:18 INFO - PROCESS | 1631 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:09:18 INFO - PROCESS | 1631 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 09:09:18 INFO - PROCESS | 1631 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:09:18 INFO - PROCESS | 1631 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:09:18 INFO - PROCESS | 1631 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:09:18 INFO - PROCESS | 1631 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 09:09:18 INFO - PROCESS | 1631 | 09:09:18 INFO - PROCESS | 1631 | ************************* 09:10:38 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:10:38 INFO - PROCESS | 1631 | RSS: Main: 367439872 09:10:38 INFO - PROCESS | 1631 | 09:13:41 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:13:42 INFO - PROCESS | 1631 | RSS: Main: 360136704 09:13:42 INFO - PROCESS | 1631 | 09:16:44 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:16:45 INFO - PROCESS | 1631 | RSS: Main: 340078592 09:16:45 INFO - PROCESS | 1631 | 09:19:48 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:19:49 INFO - PROCESS | 1631 | RSS: Main: 328847360 09:19:49 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:22:52 INFO - PROCESS | 1631 | RSS: Main: 529264640 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | __start_tp_report 09:22:52 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 09:22:52 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 09:22:52 INFO - PROCESS | 1631 | |i|pagename|runs| 09:22:52 INFO - PROCESS | 1631 | |0;dojo.html;2821.1818572613943;3348.5312056312114;3349.815760133192;3372.5952885653724;3409.829508524573;5559.471850174237;5621.325440947087;5639.295088113986;5644.407337229588;5656.9999999999945;5647.576431767613;5672.801451949183;5757.366689664133;5764.855878603037;5773.624714393551;5044.596432285427;5093.108705976458;5112.514311140454;5166.225066240057;5199.740012999354;5202.193659982709;5282.973585132069;5289.100852855005;5296.682199068068;5327.987682340362;5121.590272778206;5256.342957130359;5262.657927234717;5265.157574788034;5292.973535132319;5148.150555158394;5153.742312884378;5197.064528384889;5212.921806172911;5219.634625576211;5169.638125331228;5183.274341592142;5217.399999000126;5224.190250511177;5235.293235413246;5653.830385088454;5658.547316214693;5668.31980162379;5682.659040457585;5696.202531645573;6105.572609917308;6118.4668989547035;6271.122042913996;6281.780137695205;6287.779927702509;5155.40712818027;6235.095911092912;6237.064440333941;6281.654509002003;6325.304216536178;5826.213461182686;5830.854228644275;5833.708314584296;5835.824925252249;5856.76572937082;6195.380461953859;6341.968290158612;6352.872942541123;6357.904631430532;6374.235091788923;5971.253593300838;6015.939840601538;6018.849528761729;6099.420555047263;6116.679772652678;6102.09542342839;6289.371062893674;6294.339094395023;6296.401841825019;6305.148804911279;6106.157323464342;6108.0992441897915;6121.296050954108;6132.030754953331;6166.414190651881;6171.950768369298;6259.405356491126;6271.686415679198;6273.592216505913;6274.435300822948;4853.757312134379;4877.170880950247;4899.2896030075435;4926.679765815282;4994.475580064113;4445.533219012022;4457.465104187453;4463.285874260103;4466.709663871903;4523.36672865799;4735.976320118446;5792.681402522901;5801.3328467225965;5814.709264536757;5823.708814559255;6149.923763341398;6215.595986260879;6318.083877837687;6328.17733694626;6340.524460665469;5688.744006519716;5714.028615135437;5725;5744.454276843693;5784.1902133701315;5345.839624811262;5401.351837779492;5402.35171779389;5427.375851777097;5427.565794736412;6243.125962365363;6255.40573645503;6329.335419780857;6338.271098823602;6339.936600633934;6175.289841668266;6203;6207.627542347293;6255.093011513214;6298.527610429144;6261.812145635638;6287.056941458818;6289.371062893674;6291.245050593958;6297.874042519033;6231.9688401557705;6242.5942313749465;6249.218847644044;6254.374562543891;6268.373162683695;6129.022607377628;6164.137020816999;6193;6196.659183744757;6219.937800622117;6121.9595067255395;6155.84610384744;6159.137720719193;6165.445109940127;6183;5981.312149102735;6033.909491357545;6121.265448146251;6130.896438641087;6145.784897528565;4982.427020892499;5659.801906933238;5886.911696324473;5936.436038576328;5938;6057.848553786014;6103.267607886904;6105.328413874559;6109;6112.419320164578;5911.793087241926;5913.319968203539;5917.792877249276;5924.822255332347;5932.466078052823 09:22:52 INFO - PROCESS | 1631 | |1;ext.html;460.53025913568155;466.5707549054869;467.8105367326234;485.7037207303544;524.0750076115654;37832.81083594581;39709.43341515726;39878.2024359513;41840.163196736044;41940.37089443653;40155.996100097436;40477.59522404775;40538.72996510457;40622.39066414006;40726.185476290455;8309.252167304941;8539.786505337384;9090.81818363634;9308.953455232748;9309.813803723922;11107.333559986386;11375.544978200904;11391.145664075186;11510.712232194179;11550.53797848085;9468.526573671323;11259.437028148559;11314.264572802782;11323.150763692756;11341;11238.100951923867;11296.491657875375;11296.491657875415;11307.717307067307;11335.319880807096;11102.833457498144;11116.44417779116;11199.496022678999;11201.66395008151;11207.327560346404;38970;39256;39493;39496.81509554718;39498.80250598757;3893.357595996657;4007.7996100194873;4053.5743746906446;4082.081531655354;4195.496540415139;27220;28093.578596321073;28111.85944070287;28134.718652813415;28250.858745706344;3115.2367669921014;3270.2478429961243;3291.1772056985756;3306.8842590509216;3309.9172520686934;455131;457142;457354.71322643507;457452;458349;53198;53498.46501535013;53505.464945350825;53575.73212133914;53582.73208633932;56628.716856415456;56747;56776;56785.716071420204;56802;15063.096214227182;15301.617459563377;15305.387784488496;15312.234388280542;15315.770263446057;10666.093382062612;10905.618303359344;10922.399268040333;11812.114091443176;11850.525978960744;17345.56636084083;17896.731549026776;17918.372856949944;17922.28310867577;17931;6879.277675843964;7748.597934640279;7838.490498117604;7857.7249796258;7932.08780990182;717.8277213468834;818.6479813680056;855.234565064264;863.3999370437612;869.1135042256863;28741.56887646687;28784.992525261514;28835.855820721183;29441.55837662437;29532.557011644843;1025.2259544044198;1028.7890982348601;1055.8996895294936;1055.9102476289602;1164.4352489042808;11728.70678233051;12834.743305133845;13668.316584170752;13746.862531374758;13996.930015349859;589325;592783;594060;594081;594484;48584.514154858;49107.50892491101;49181;49223.507764921895;49289.767755806395;1408.5281430720822;1447.4065633090383;1454.9742431585496;1464.2532308522943;1475.1370448287657;24733.25800225996;25875.932942646836;26103.477930441666;26313.4737305249;26521.867390662923;42049.78975105105;44704;44724;44743.328850066624;44820.55179448294;553198;553315;558218;559286;559732;23572.52854942857;23949.760502394754;23968.161114360915;24002.159924402564;24029.639555407033;33644.83177584096;39287;41869.069165158144;41874.79062604789;43695.344569832116;33310.50034249537;33593.32813343768;34680.30639387148;35457.29085418329;35546.46680299849;29360;32641.020769376955;33252.50121248135;33757.32485350328;33825;32421.35157296794;33091.84178553835;33161;33235.50146747849;33288.83355583207;29801.403971920874;29902.102936911928;29959.70040299569;30655;30662.386752265276;20428.897855510626;20985.370438886857;22581.887090564443;23101;23114.768852311263 09:22:52 INFO - PROCESS | 1631 | |2;jquery.html;378.30014473224554;395.2865078533246;397.66397394201897;403.270081153113;422.2926597948436;14281.571552853406;16220.270087846045;18562;20964.532482726216;21302.786972130274;19885.40343789685;20003.39989800305;20383.490412739688;22152.335429937128;22555.774442255573;5825.854353641151;5826.737796799154;5959;5999.040153575429;6057.787977420791;5851.912221316684;5946.167536544887;5992.0712289595185;5994.490468310199;5998.790042348519;4030.435738996543;5951.732172052247;6213.937860621404;6488.383603557654;6526.738930442777;6405.203291021633;6452.483801295885;6597.373249541286;6613.074169616258;6631.237407698129;5744.712764361765;5745.741441635095;5749.453801888814;5752.395998420189;5764.7117644117625;20926.581468370547;26110;27299.454010919868;27330.726692733017;27591;2694.353355194759;2722;2727.836329820217;2769.5984082308155;2775.5420355641295;10384.065434110966;13760.105593136414;13829.861701382957;16177.83822161775;16186.75719864203;1792.6325103353781;1797.7842658880886;1824.5438640339914;1853.5736780540417;1864.6177533605578;122116;122966;125033.74966250312;126898.36550817279;127626.36186819099;11463.770724585629;11543.653690389301;11689.707757306136;11794.646160615195;11873.050155987674;15143.848561514464;15578.143202123765;15611.453599123975;15613;15618.375264989274;8592.269657079218;8779.165979231962;8799.032106468283;8842.336824738042;8901.777455563533;8470.872936905951;8561.101084386175;8577.656893724181;8719.869201961976;8755.124487551195;4751.572358487683;4784.425868895755;4786.856394308176;4797;4851.078295123915;1817.354839032151;2009.4674911148556;2010.095457044336;2015.3550863723467;2016.949576260576;1004.5634742318408;1018.8624535687735;1019.56158851693;1028.4343611014062;1066.5068903535114;22228.333150005525;22477.4380640482;22677.546449070927;22680.206192783175;22722.318330449783;1051.574112484445;1054.4991129213563;1057.0740744409995;1077.671310250381;1077.8113830079706;10745.946270268598;11165.771765105832;11615.825762613567;11671.708207294716;11674.94162529199;639558;702700;708938;718712;726457;114764;115760;130997;139678;147568.78646820306;897.6095398501673;971.523953262896;993.4635296939572;1125.831125331207;1136.2387200575633;16993.06538140414;18940.768850024706;20320.695189572463;20689.27587534429;20716.79283207209;60296.69851650714;60769.392306078145;61139.08291375544;61577.69211153915;62230.68884655548;89197;89980;91605.5419722897;91614.08385916056;92052.69868253348;5884.499817515559;7430.034095567542;7503.624818759149;8092.797680058045;8675.86986195195;12491.37543122822;12653.608103108467;12802.67993300175;13688.863111368759;13781;10742.89257107419;11247.943760281147;11321.03771179459;11588.420578970849;11769.411529423665;9712.465814380277;11419.657410277705;11490.827637585277;11679.883201167879;11828.876256755595;10379.53292101842;11306.434678265889;11591.884081159418;11599.478023488795;11932.821007684717;7442.367398771165;7552.509086909334;7588.203238660082;7617.65720542588;7678.270564296383;8282.337413007066;9287.86068208991;10841.512131953923;10931.398773067558;11230.583044060557 09:22:52 INFO - PROCESS | 1631 | |3;mootools.html;1426.9072510286824;1451.47746811148;1455.3378212913126;1472.0284612155979;1476.8006319146912;8035.9196408035905;8453.408261421702;8459.32325413967;8465.407421480491;8467.91532084679;7366.484346095775;7656.234376562355;7656.885146722803;7957.72147974821;8194.426390152692;2285.6228722260807;2323.0939933425893;2323.860568365895;2325.732540757809;2326.220716060122;2316.224064938248;2334.26470661741;2341.203990643181;2341.2390972933863;2346.8122550195944;1918.6450506656242;1936.8741031832956;2299.2527428585695;2317.895694693734;2322.8722420266877;2247.8763667998337;2269.1263863412705;2279.2934190400947;2297.7357603875603;2306.630939049761;1922.298361098203;2283.8858057097245;2315.351701523576;2315.7452680205333;2318.9304320870233;8251.546164960924;8401.41190116692;8409.327253819742;8414.83170336596;8420.915790842075;5005.174146265898;5051.898962020739;5178.766955487012;5182.663126896739;5192.091384007784;2755.2423083651956;3210.9197270068203;3470.1845066409373;3471.7222622190416;3474.6699063588917;1186.833843261944;1189.6371606659966;1207.7765613361555;1228.0298564134412;1240.6712221261373;10693.251472396858;10715.624953126604;10723.410212438235;10780.51487683056;10807.02736753688;3863.9613603864163;4348.173846969065;4632.652551058617;4652;4673.719576825401;9327.554229094501;9331.626734930662;9337.112974267433;9337.673181438617;9354.251659867194;5211.296474975906;5218.921716174261;5219.634625576173;5225.608079394061;5230.424653288135;4280.636145927569;4431.290993441034;4459.9331010034875;4661.766911654404;4759.571638552547;3737.6822970047306;3784.7729136251914;3820.9426858597144;3885.2812229737588;3889.591592882763;1259.055708218836;1259.5263541656284;1266.3098611256887;1274.6749578857332;1282.5254655777421;778.8948491953514;848.4061157189992;906.7823722306731;912.8539433690711;937.8546325319586;5393.892122157535;5458.153986132156;5567.805126820542;5706.971465142731;5734.62724922887;960.7165886063628;987.3483500889522;995.2286977592424;1010.3988127064385;1034.9689509314733;3543.734219933464;3638.4178531434845;3639.745217834779;3706.962930370662;3857.2285542890972;8279.461834980708;9657.22742180624;9970.50147492637;9995.900040999497;10006.54970526328;9295.628174873065;9778.07108324708;9914.157296629868;9932.453715045742;9938.503074846374;7581.279778421042;7769.261920117579;7774.922250777533;7777.961110194526;7779.72770953014;4474.888127796831;5512.779488820563;5686.175504551899;5736.913946290892;5753.683547404933;8746.562671866508;8794.516301603473;9093.136152065543;9235.07649235071;9238.30712696564;9208.987011428871;9238.399504032217;9308.208802251884;9338.299627527827;9420.340576159602;6572.934270657232;6602.7689030883685;6786.830329241809;6999.30006999296;7130;7781.221877812173;7881.566513841564;7942.444028918151;7958.880616790869;7971.1630278819885;5938.673372964528;6995.020697102512;7070.575765454089;7103.396211321889;7179.7128114876905;6929;6947;6955;6998.895016574857;7009.9649501752165;6192;6237.095621134819;6297.716602752796;6383.616982981036;6394;4071;4435.379046933367;4930.9506904930495;4972.65191436596;5043.52086551777;4868.464468908346;4908.312836203006;4972.105021096238;5062.721550314768;5171.767270472913 09:22:52 INFO - PROCESS | 1631 | |4;prototype.html;321.4743893733746;344.82241645552534;358.6359844757571;359.78952312896956;374.7788804605282;4510;4652.790274528622;4953.058918805429;5260.92108618371;5262.710720836434;4126.133511962484;4241.851535196269;4295.787669350287;4505.662075344346;4939.925901111486;3913.530376354834;4055.878323650295;4073.877783666495;4155.296328505314;4162.666986641061;3764.5670747864074;4089.6114869087537;4098.585987834207;4134.586541345871;4143;3642.8724994625195;3978.0308747170047;4104.01503639126;4105.958940410603;4111.917761644765;3660.5607327120783;3954.644082032602;3970.563238043813;3974.3839704845795;3998.6001399860074;3273;3446.7414943879057;3455.550778398792;3458.87893923714;3462.7056700180515;5060.51925067118;5087.287779710843;5105.489451054865;5112.846614601531;5129.589632829365;3894.2990261752875;4308.181445525372;4485.506594274627;4576.604135738598;4593.770311484446;5051.368578927634;5459.563234941195;5553.7778488860395;5559.360673522557;5566.2207290979295;3265.689759472846;3775.6601905828607;3812.066043819282;3820.44603532489;3820.522434695663;4840.636952228597;4963.071787645271;5536.474034966672;5584.5811564132855;5774.97112514439;3401.295969704091;3752.193278445093;3816.072883193969;3839.731218814712;3855.7443895321553;3195.5526226328334;3663.6735672847935;3721.627837216257;3893.824777885002;3918.5885482024546;4223.72545784523;4264;4495.303227999665;4539.933115717804;4568;5006.3992320921725;5190.325257716549;5594.216809646653;5651.434856514398;5669.489745922887;1265.7721610110268;1265.9873401266054;1268.1123213750411;1277.8754695867576;1286.9832832062752;657.5430076097067;810.4084018666289;816.6243527977197;844.5397258494136;861.5046348349724;4866.564363512773;4908.312836202935;4964.8758781030765;4984.00639744098;4986.401631804134;4484.251142054602;5255.527002569787;5318.308619879391;5365.919511207335;5412.458754124635;4520.88697782558;4562.452505699337;4748.881277968078;4799.952000480021;5315.548178404802;2748.763056624527;2755.9035433759723;2802.1313392848283;2825.4631619992138;2860.284928767808;5094.4141423736;5263.0526705119355;5559.19391688211;5667.716614169358;5701.828945131652;4858.299595141672;5022.397312322471;5159.690418574897;5217.6867689017745;5274.123519213375;4587.967707265839;4840.643420921128;5177.663451875616;5437.32033495813;5594.888102237933;4743.291623305173;4835.734034627989;5128.948710512847;5235.581153507786;5375.919361209663;4390.538993405647;4953.563466594791;4985.376827896513;5456.727163641723;5503.7066289422755;4995.550400463976;5465.808696695596;5590.338328394908;5698.686572238401;5896.815719511415;3226.951595726019;3401.4727717203873;3616.5298511193378;3633.473146393811;3766.717496187742;4210.084411592779;5201.635885488131;5493.533933735958;5696.458836410535;5744.281964754406;5020.748962551785;5037.395512538519;5553.972230138824;5569.081101618188;5682.147677848356;5094.2867998479505;5246.31797866275;5520.889582208253;5542.418046105101;5669.6314739541795;4129.938050929179;4608.953910460852;5399.757010934596;5443.700596467233;5495.835124946258;4305.6986010978935;5260.42343161452;5380.385884234792;5401.864953376197;5403.378611459732;4586.908261834811;5379.273798037371;5392.433794451683;5404.459554044564;5427.367726652491 09:22:52 INFO - PROCESS | 1631 | |5;yui.html;696.6725638949694;726.4370113162295;735.7376068589086;772.2663469703783;816.6651672814147;14874.851251487482;15886.046837189748;15888.205589720526;15915.44295949642;15933.442329518455;14404.423823047066;14534.709305813878;14735.410583576671;14748.26258687064;14748.483803066894;680.5134328954796;705.7776800307912;727.7380143148463;850.3834719828137;884.1556313720414;870.8214815962713;876.3865294293988;886.167003017165;886.7738726624701;886.835935351962;940.1820416237848;942.6936245720134;942.9009953954838;944.9527523623825;945.229637845154;728.6757392960135;750.3846845586621;937.7983733497263;938.6714649872592;939.9906000940006;663.73450619752;681.4786688183543;688.9827754306133;691.3915754136378;693.549193024533;14696.971212015163;14750.336234869457;15151.469698560497;15156.1664108474;15215.934884558086;13467.191968481922;13553.051286409955;13599.52401665937;13852.515161969282;13913.930430347884;10762.3542587445;13035;13107.016973727008;13121.671958201026;13492.12301200419;3676.7977761223124;4013.4180543821276;4804.279358096313;4871.342368780241;4876.951230487721;109952.90047099507;110045.44977275142;112425.43787281093;112770;113854.43072784666;9691.176250018687;10787.568497260021;11730.589429369931;11801.822972655416;11895.252542836433;23811.880940595533;24228.51542969166;24236.636450453258;24244.272671819523;24281.39296517566;8092.878606820902;8100;8119.350451963829;8314.127016663284;8350.958245208734;4296.5273819879785;4355.716878402894;4356.956430435718;4361.1495758327455;4361.323994780814;3620.7827530348263;3722.236941427055;3726.1988672435555;3734.9626503734617;3743.513343265358;603.4599033864666;679.9218089919624;684.0764967294213;690.5407903743954;700.2227527444533;609.8353444569941;613.9140520327157;654.443722835586;672.9703553563056;708.4367927497651;9298.410753684275;9360.4383736976;10189.05531838941;10689.198310126772;10751.354918704903;573.5468979506227;578.138573525444;614.582084182751;621.0373920423326;724.3589423360364;4440.489343725449;4935.555799978019;5020.347354843847;5023.623228257895;5159.25190847325;71414.64292678607;95783.04216957881;95956.04043959471;96239;98007;64899;67828;71311.75400363901;81438.59280703559;85839.5708021456;70163.2983670167;70596;70822;71900;72883;9727.756806079622;9780.804383912424;9798.65704700332;9820;9826.459544725109;43188.784056079516;46393.53606463892;49227.75386123046;49881.50118498768;50395.992080158925;62843;64631.67684161549;65099.67450162719;65837.34162658504;66939;11615.535378584762;11826.704332391759;11864.466099025392;11866.110041746731;12143.33211673331;12902.354882255662;13063.085584009408;13330.733385332433;13359.332033398097;13403.798943015667;10507.31702439339;10716.410597417216;11950.223235489666;12219;12639.747205056032;11409.087273017973;13481.393337299649;14018.649533761738;14290.928545357207;14432.206228657524;13390.309133559475;13688.726225475633;13718.519851805138;13867.167969921837;13873.722525549634;11348.546058157912;11385.30677987988;11513.251638643796;11548.931366721963;11564.363959982282;9728.17310528613;10438.425886576311;11228.644399811485;11374.772504550028;11418.942905285421 09:22:52 INFO - PROCESS | 1631 | __end_tp_report 09:22:52 INFO - PROCESS | 1631 | __start_cc_report 09:22:52 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,2150 09:22:52 INFO - PROCESS | 1631 | __end_cc_report 09:22:52 INFO - PROCESS | 1631 | __startTimestamp1484328172804__endTimestamp 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | ------- Summary: start ------- 09:22:52 INFO - PROCESS | 1631 | Number of tests: 6 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5726.52 Median:5924.82 stddev:656.38 (11.1%) stddev-sans-first:617.56 09:22:52 INFO - PROCESS | 1631 | Values: 2821.2 3348.5 3349.8 3372.6 3409.8 5559.5 5621.3 5639.3 5644.4 5657.0 5647.6 5672.8 5757.4 5764.9 5773.6 5044.6 5093.1 5112.5 5166.2 5199.7 5202.2 5283.0 5289.1 5296.7 5328.0 5121.6 5256.3 5262.7 5265.2 5293.0 5148.2 5153.7 5197.1 5212.9 5219.6 5169.6 5183.3 5217.4 5224.2 5235.3 5653.8 5658.5 5668.3 5682.7 5696.2 6105.6 6118.5 6271.1 6281.8 6287.8 5155.4 6235.1 6237.1 6281.7 6325.3 5826.2 5830.9 5833.7 5835.8 5856.8 6195.4 6342.0 6352.9 6357.9 6374.2 5971.3 6015.9 6018.8 6099.4 6116.7 6102.1 6289.4 6294.3 6296.4 6305.1 6106.2 6108.1 6121.3 6132.0 6166.4 6172.0 6259.4 6271.7 6273.6 6274.4 4853.8 4877.2 4899.3 4926.7 4994.5 4445.5 4457.5 4463.3 4466.7 4523.4 4736.0 5792.7 5801.3 5814.7 5823.7 6149.9 6215.6 6318.1 6328.2 6340.5 5688.7 5714.0 5725.0 5744.5 5784.2 5345.8 5401.4 5402.4 5427.4 5427.6 6243.1 6255.4 6329.3 6338.3 6339.9 6175.3 6203.0 6207.6 6255.1 6298.5 6261.8 6287.1 6289.4 6291.2 6297.9 6232.0 6242.6 6249.2 6254.4 6268.4 6129.0 6164.1 6193.0 6196.7 6219.9 6122.0 6155.8 6159.1 6165.4 6183.0 5981.3 6033.9 6121.3 6130.9 6145.8 4982.4 5659.8 5886.9 5936.4 5938.0 6057.8 6103.3 6105.3 6109.0 6112.4 5911.8 5913.3 5917.8 5924.8 5932.5 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:65545.09 Median:33270.67 stddev:143951.26 (432.7%) stddev-sans-first:144272.14 09:22:52 INFO - PROCESS | 1631 | Values: 460.5 466.6 467.8 485.7 524.1 37832.8 39709.4 39878.2 41840.2 41940.4 40156.0 40477.6 40538.7 40622.4 40726.2 8309.3 8539.8 9090.8 9309.0 9309.8 11107.3 11375.5 11391.1 11510.7 11550.5 9468.5 11259.4 11314.3 11323.2 11341.0 11238.1 11296.5 11296.5 11307.7 11335.3 11102.8 11116.4 11199.5 11201.7 11207.3 38970.0 39256.0 39493.0 39496.8 39498.8 3893.4 4007.8 4053.6 4082.1 4195.5 27220.0 28093.6 28111.9 28134.7 28250.9 3115.2 3270.2 3291.2 3306.9 3309.9 455131.0 457142.0 457354.7 457452.0 458349.0 53198.0 53498.5 53505.5 53575.7 53582.7 56628.7 56747.0 56776.0 56785.7 56802.0 15063.1 15301.6 15305.4 15312.2 15315.8 10666.1 10905.6 10922.4 11812.1 11850.5 17345.6 17896.7 17918.4 17922.3 17931.0 6879.3 7748.6 7838.5 7857.7 7932.1 717.8 818.6 855.2 863.4 869.1 28741.6 28785.0 28835.9 29441.6 29532.6 1025.2 1028.8 1055.9 1055.9 1164.4 11728.7 12834.7 13668.3 13746.9 13996.9 589325.0 592783.0 594060.0 594081.0 594484.0 48584.5 49107.5 49181.0 49223.5 49289.8 1408.5 1447.4 1455.0 1464.3 1475.1 24733.3 25875.9 26103.5 26313.5 26521.9 42049.8 44704.0 44724.0 44743.3 44820.6 553198.0 553315.0 558218.0 559286.0 559732.0 23572.5 23949.8 23968.2 24002.2 24029.6 33644.8 39287.0 41869.1 41874.8 43695.3 33310.5 33593.3 34680.3 35457.3 35546.5 29360.0 32641.0 33252.5 33757.3 33825.0 32421.4 33091.8 33161.0 33235.5 33288.8 29801.4 29902.1 29959.7 30655.0 30662.4 20428.9 20985.4 22581.9 23101.0 23114.8 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:38899.01 Median:22516.61 stddev:116309.48 (516.5%) stddev-sans-first:116599.80 09:22:52 INFO - PROCESS | 1631 | Values: 378.3 395.3 397.7 403.3 422.3 14281.6 16220.3 18562.0 20964.5 21302.8 19885.4 20003.4 20383.5 22152.3 22555.8 5825.9 5826.7 5959.0 5999.0 6057.8 5851.9 5946.2 5992.1 5994.5 5998.8 4030.4 5951.7 6213.9 6488.4 6526.7 6405.2 6452.5 6597.4 6613.1 6631.2 5744.7 5745.7 5749.5 5752.4 5764.7 20926.6 26110.0 27299.5 27330.7 27591.0 2694.4 2722.0 2727.8 2769.6 2775.5 10384.1 13760.1 13829.9 16177.8 16186.8 1792.6 1797.8 1824.5 1853.6 1864.6 122116.0 122966.0 125033.7 126898.4 127626.4 11463.8 11543.7 11689.7 11794.6 11873.1 15143.8 15578.1 15611.5 15613.0 15618.4 8592.3 8779.2 8799.0 8842.3 8901.8 8470.9 8561.1 8577.7 8719.9 8755.1 4751.6 4784.4 4786.9 4797.0 4851.1 1817.4 2009.5 2010.1 2015.4 2016.9 1004.6 1018.9 1019.6 1028.4 1066.5 22228.3 22477.4 22677.5 22680.2 22722.3 1051.6 1054.5 1057.1 1077.7 1077.8 10745.9 11165.8 11615.8 11671.7 11674.9 639558.0 702700.0 708938.0 718712.0 726457.0 114764.0 115760.0 130997.0 139678.0 147568.8 897.6 971.5 993.5 1125.8 1136.2 16993.1 18940.8 20320.7 20689.3 20716.8 60296.7 60769.4 61139.1 61577.7 62230.7 89197.0 89980.0 91605.5 91614.1 92052.7 5884.5 7430.0 7503.6 8092.8 8675.9 12491.4 12653.6 12802.7 13688.9 13781.0 10742.9 11247.9 11321.0 11588.4 11769.4 9712.5 11419.7 11490.8 11679.9 11828.9 10379.5 11306.4 11591.9 11599.5 11932.8 7442.4 7552.5 7588.2 7617.7 7678.3 8282.3 9287.9 10841.5 10931.4 11230.6 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:5354.72 Median:5219.28 stddev:2917.53 (55.9%) stddev-sans-first:2910.79 09:22:52 INFO - PROCESS | 1631 | Values: 1426.9 1451.5 1455.3 1472.0 1476.8 8035.9 8453.4 8459.3 8465.4 8467.9 7366.5 7656.2 7656.9 7957.7 8194.4 2285.6 2323.1 2323.9 2325.7 2326.2 2316.2 2334.3 2341.2 2341.2 2346.8 1918.6 1936.9 2299.3 2317.9 2322.9 2247.9 2269.1 2279.3 2297.7 2306.6 1922.3 2283.9 2315.4 2315.7 2318.9 8251.5 8401.4 8409.3 8414.8 8420.9 5005.2 5051.9 5178.8 5182.7 5192.1 2755.2 3210.9 3470.2 3471.7 3474.7 1186.8 1189.6 1207.8 1228.0 1240.7 10693.3 10715.6 10723.4 10780.5 10807.0 3864.0 4348.2 4632.7 4652.0 4673.7 9327.6 9331.6 9337.1 9337.7 9354.3 5211.3 5218.9 5219.6 5225.6 5230.4 4280.6 4431.3 4459.9 4661.8 4759.6 3737.7 3784.8 3820.9 3885.3 3889.6 1259.1 1259.5 1266.3 1274.7 1282.5 778.9 848.4 906.8 912.9 937.9 5393.9 5458.2 5567.8 5707.0 5734.6 960.7 987.3 995.2 1010.4 1035.0 3543.7 3638.4 3639.7 3707.0 3857.2 8279.5 9657.2 9970.5 9995.9 10006.5 9295.6 9778.1 9914.2 9932.5 9938.5 7581.3 7769.3 7774.9 7778.0 7779.7 4474.9 5512.8 5686.2 5736.9 5753.7 8746.6 8794.5 9093.1 9235.1 9238.3 9209.0 9238.4 9308.2 9338.3 9420.3 6572.9 6602.8 6786.8 6999.3 7130.0 7781.2 7881.6 7942.4 7958.9 7971.2 5938.7 6995.0 7070.6 7103.4 7179.7 6929.0 6947.0 6955.0 6998.9 7010.0 6192.0 6237.1 6297.7 6383.6 6394.0 4071.0 4435.4 4931.0 4972.7 5043.5 4868.5 4908.3 4972.1 5062.7 5171.8 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4345.57 Median:4840.64 stddev:1310.08 (27.1%) stddev-sans-first:1278.46 09:22:52 INFO - PROCESS | 1631 | Values: 321.5 344.8 358.6 359.8 374.8 4510.0 4652.8 4953.1 5260.9 5262.7 4126.1 4241.9 4295.8 4505.7 4939.9 3913.5 4055.9 4073.9 4155.3 4162.7 3764.6 4089.6 4098.6 4134.6 4143.0 3642.9 3978.0 4104.0 4106.0 4111.9 3660.6 3954.6 3970.6 3974.4 3998.6 3273.0 3446.7 3455.6 3458.9 3462.7 5060.5 5087.3 5105.5 5112.8 5129.6 3894.3 4308.2 4485.5 4576.6 4593.8 5051.4 5459.6 5553.8 5559.4 5566.2 3265.7 3775.7 3812.1 3820.4 3820.5 4840.6 4963.1 5536.5 5584.6 5775.0 3401.3 3752.2 3816.1 3839.7 3855.7 3195.6 3663.7 3721.6 3893.8 3918.6 4223.7 4264.0 4495.3 4539.9 4568.0 5006.4 5190.3 5594.2 5651.4 5669.5 1265.8 1266.0 1268.1 1277.9 1287.0 657.5 810.4 816.6 844.5 861.5 4866.6 4908.3 4964.9 4984.0 4986.4 4484.3 5255.5 5318.3 5365.9 5412.5 4520.9 4562.5 4748.9 4800.0 5315.5 2748.8 2755.9 2802.1 2825.5 2860.3 5094.4 5263.1 5559.2 5667.7 5701.8 4858.3 5022.4 5159.7 5217.7 5274.1 4588.0 4840.6 5177.7 5437.3 5594.9 4743.3 4835.7 5128.9 5235.6 5375.9 4390.5 4953.6 4985.4 5456.7 5503.7 4995.6 5465.8 5590.3 5698.7 5896.8 3227.0 3401.5 3616.5 3633.5 3766.7 4210.1 5201.6 5493.5 5696.5 5744.3 5020.7 5037.4 5554.0 5569.1 5682.1 5094.3 5246.3 5520.9 5542.4 5669.6 4129.9 4609.0 5399.8 5443.7 5495.8 4305.7 5260.4 5380.4 5401.9 5403.4 4586.9 5379.3 5392.4 5404.5 5427.4 09:22:52 INFO - PROCESS | 1631 | 09:22:52 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:19646.85 Median:25598.91 stddev:27681.28 (108.1%) stddev-sans-first:27722.36 09:22:52 INFO - PROCESS | 1631 | Values: 696.7 726.4 735.7 772.3 816.7 14874.9 15886.0 15888.2 15915.4 15933.4 14404.4 14534.7 14735.4 14748.3 14748.5 680.5 705.8 727.7 850.4 884.2 870.8 876.4 886.2 886.8 886.8 940.2 942.7 942.9 945.0 945.2 728.7 750.4 937.8 938.7 940.0 663.7 681.5 689.0 691.4 693.5 14697.0 14750.3 15151.5 15156.2 15215.9 13467.2 13553.1 13599.5 13852.5 13913.9 10762.4 13035.0 13107.0 13121.7 13492.1 3676.8 4013.4 4804.3 4871.3 4877.0 109952.9 110045.4 112425.4 112770.0 113854.4 9691.2 10787.6 11730.6 11801.8 11895.3 23811.9 24228.5 24236.6 24244.3 24281.4 8092.9 8100.0 8119.4 8314.1 8351.0 4296.5 4355.7 4357.0 4361.1 4361.3 3620.8 3722.2 3726.2 3735.0 3743.5 603.5 679.9 684.1 690.5 700.2 609.8 613.9 654.4 673.0 708.4 9298.4 9360.4 10189.1 10689.2 10751.4 573.5 578.1 614.6 621.0 724.4 4440.5 4935.6 5020.3 5023.6 5159.3 71414.6 95783.0 95956.0 96239.0 98007.0 64899.0 67828.0 71311.8 81438.6 85839.6 70163.3 70596.0 70822.0 71900.0 72883.0 9727.8 9780.8 9798.7 9820.0 9826.5 43188.8 46393.5 49227.8 49881.5 50396.0 62843.0 64631.7 65099.7 65837.3 66939.0 11615.5 11826.7 11864.5 11866.1 12143.3 12902.4 13063.1 13330.7 13359.3 13403.8 10507.3 10716.4 11950.2 12219.0 12639.7 11409.1 13481.4 14018.6 14290.9 14432.2 13390.3 13688.7 13718.5 13867.2 13873.7 11348.5 11385.3 11513.3 11548.9 11564.4 9728.2 10438.4 11228.6 11374.8 11418.9 09:22:52 INFO - PROCESS | 1631 | -------- Summary: end -------- 09:22:52 INFO - PROCESS | 1631 | 09:22:53 INFO - TEST-INFO | 1631: exit 0 09:22:53 INFO - TEST-OK | dromaeo_css | took 1119412ms 09:22:53 INFO - TEST-START | kraken 09:22:53 INFO - operating with platform_type : mac_ 09:22:53 INFO - Initialising browser for kraken test... 09:22:53 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp4_M8p5/profile http://localhost:49241/getInfo.html) 09:22:55 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 09:22:55 INFO - PROCESS | 1641 | colorDepth:24 09:22:55 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 09:22:55 INFO - PROCESS | 1641 | __metrics 09:22:55 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:22:55 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:56 INFO - TEST-INFO | 1641: exit 0 09:22:56 INFO - Browser initialized. 09:22:56 INFO - Running cycle 1/1 for kraken test... 09:22:56 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp4_M8p5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:08 INFO - PROCESS | 1642 | RSS: Main: 235220992 09:23:08 INFO - PROCESS | 1642 | 09:23:11 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:12 INFO - PROCESS | 1642 | RSS: Main: 287002624 09:23:12 INFO - PROCESS | 1642 | 09:23:14 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:23:15 INFO - PROCESS | 1642 | RSS: Main: 287838208 09:23:15 INFO - PROCESS | 1642 | 09:23:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:23:19 INFO - PROCESS | 1642 | RSS: Main: 380461056 09:23:19 INFO - PROCESS | 1642 | 09:23:21 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:23:22 INFO - PROCESS | 1642 | RSS: Main: 282988544 09:23:22 INFO - PROCESS | 1642 | 09:23:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:24 INFO - PROCESS | 1642 | RSS: Main: 286642176 09:23:24 INFO - PROCESS | 1642 | 09:23:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:28 INFO - PROCESS | 1642 | RSS: Main: 330436608 09:23:28 INFO - PROCESS | 1642 | 09:23:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:31 INFO - PROCESS | 1642 | RSS: Main: 329916416 09:23:31 INFO - PROCESS | 1642 | 09:23:34 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:23:35 INFO - PROCESS | 1642 | RSS: Main: 329756672 09:23:35 INFO - PROCESS | 1642 | 09:23:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:37 INFO - PROCESS | 1642 | RSS: Main: 302850048 09:23:37 INFO - PROCESS | 1642 | 09:23:39 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:39 INFO - PROCESS | 1642 | RSS: Main: 307613696 09:23:39 INFO - PROCESS | 1642 | 09:23:42 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:42 INFO - PROCESS | 1642 | RSS: Main: 308862976 09:23:42 INFO - PROCESS | 1642 | 09:23:45 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:46 INFO - PROCESS | 1642 | RSS: Main: 327684096 09:23:46 INFO - PROCESS | 1642 | 09:23:49 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:50 INFO - PROCESS | 1642 | RSS: Main: 321134592 09:23:50 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:23:51 INFO - PROCESS | 1642 | RSS: Main: 364974080 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | __start_tp_report 09:23:51 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 09:23:51 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 09:23:51 INFO - PROCESS | 1642 | |i|pagename|runs| 09:23:51 INFO - PROCESS | 1642 | |0;ai-astar;113;114;114;112;110;114;111;112;114;113 09:23:51 INFO - PROCESS | 1642 | |1;audio-beat-detection;147;111;104;144;114;117;140;100;113;132 09:23:51 INFO - PROCESS | 1642 | |2;audio-dft;182;182;181;183;183;183;184;179;190;181 09:23:51 INFO - PROCESS | 1642 | |3;audio-fft;79;58;62;88;60;58;59;59;74;52 09:23:51 INFO - PROCESS | 1642 | |4;audio-oscillator;90;68;83;68;68;69;99;95;93;83 09:23:51 INFO - PROCESS | 1642 | |5;imaging-gaussian-blur;87;86;88;85;86;84;87;85;86;84 09:23:51 INFO - PROCESS | 1642 | |6;imaging-darkroom;92;93;93;93;93;107;148;117;93;93 09:23:51 INFO - PROCESS | 1642 | |7;imaging-desaturate;95;118;85;88;87;84;87;82;88;85 09:23:51 INFO - PROCESS | 1642 | |8;json-parse-financial;57;57;54;55;55;52;56;55;55;56 09:23:51 INFO - PROCESS | 1642 | |9;json-stringify-tinderbox;73;73;79;70;71;68;69;68;70;72 09:23:51 INFO - PROCESS | 1642 | |10;stanford-crypto-aes;85;87;87;87;87;99;108;103;89;86 09:23:51 INFO - PROCESS | 1642 | |11;stanford-crypto-ccm;142;140;141;139;140;144;134;159;203;142 09:23:51 INFO - PROCESS | 1642 | |12;stanford-crypto-pbkdf2;173;171;173;171;170;204;171;174;174;172 09:23:51 INFO - PROCESS | 1642 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;68;65;66;66;65 09:23:51 INFO - PROCESS | 1642 | __end_tp_report 09:23:51 INFO - PROCESS | 1642 | __start_cc_report 09:23:51 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2075 09:23:51 INFO - PROCESS | 1642 | __end_cc_report 09:23:51 INFO - PROCESS | 1642 | __startTimestamp1484328231978__endTimestamp 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | ------- Summary: start ------- 09:23:51 INFO - PROCESS | 1642 | Number of tests: 14 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:1.42 (1.2%) stddev-sans-first:1.50 09:23:51 INFO - PROCESS | 1642 | Values: 113.0 114.0 114.0 112.0 110.0 114.0 111.0 112.0 114.0 113.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:124.50 stddev:17.10 (13.7%) stddev-sans-first:15.61 09:23:51 INFO - PROCESS | 1642 | Values: 147.0 111.0 104.0 144.0 114.0 117.0 140.0 100.0 113.0 132.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:2.90 (1.6%) stddev-sans-first:3.06 09:23:51 INFO - PROCESS | 1642 | Values: 182.0 182.0 181.0 183.0 183.0 183.0 184.0 179.0 190.0 181.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#3] audio-fft Cycles:10 Average:64.90 Median:61.00 stddev:11.45 (18.8%) stddev-sans-first:10.94 09:23:51 INFO - PROCESS | 1642 | Values: 79.0 58.0 62.0 88.0 60.0 58.0 59.0 59.0 74.0 52.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:86.50 stddev:12.47 (14.4%) stddev-sans-first:12.85 09:23:51 INFO - PROCESS | 1642 | Values: 90.0 68.0 83.0 68.0 68.0 69.0 99.0 95.0 93.0 83.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 09:23:51 INFO - PROCESS | 1642 | Values: 87.0 86.0 88.0 85.0 86.0 84.0 87.0 85.0 86.0 84.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:93.00 stddev:18.11 (19.5%) stddev-sans-first:18.83 09:23:51 INFO - PROCESS | 1642 | Values: 92.0 93.0 93.0 93.0 93.0 107.0 148.0 117.0 93.0 93.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#7] imaging-desaturate Cycles:10 Average:89.90 Median:87.00 stddev:10.46 (12.0%) stddev-sans-first:10.93 09:23:51 INFO - PROCESS | 1642 | Values: 95.0 118.0 85.0 88.0 87.0 84.0 87.0 82.0 88.0 85.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.48 (2.7%) stddev-sans-first:1.41 09:23:51 INFO - PROCESS | 1642 | Values: 57.0 57.0 54.0 55.0 55.0 52.0 56.0 55.0 55.0 56.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.27 (4.6%) stddev-sans-first:3.41 09:23:51 INFO - PROCESS | 1642 | Values: 73.0 73.0 79.0 70.0 71.0 68.0 69.0 68.0 70.0 72.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:87.00 stddev:8.30 (9.5%) stddev-sans-first:8.43 09:23:51 INFO - PROCESS | 1642 | Values: 85.0 87.0 87.0 87.0 87.0 99.0 108.0 103.0 89.0 86.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:142.00 stddev:20.24 (14.3%) stddev-sans-first:21.33 09:23:51 INFO - PROCESS | 1642 | Values: 142.0 140.0 141.0 139.0 140.0 144.0 134.0 159.0 203.0 142.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:173.00 stddev:10.18 (5.9%) stddev-sans-first:10.76 09:23:51 INFO - PROCESS | 1642 | Values: 173.0 171.0 173.0 171.0 170.0 204.0 171.0 174.0 174.0 172.0 09:23:51 INFO - PROCESS | 1642 | 09:23:51 INFO - PROCESS | 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 09:23:51 INFO - PROCESS | 1642 | Values: 68.0 68.0 67.0 67.0 67.0 68.0 65.0 66.0 66.0 65.0 09:23:51 INFO - PROCESS | 1642 | -------- Summary: end -------- 09:23:51 INFO - PROCESS | 1642 | 09:23:52 INFO - TEST-INFO | 1642: exit 0 09:23:52 INFO - TEST-OK | kraken | took 59372ms 09:23:52 INFO - SUITE-END | took 1178s 09:23:53 INFO - Completed test suite (00:19:39) 09:23:53 INFO - javascript benchmark 09:23:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2821.1818572613943, 3348.5312056312114, 3349.815760133192, 3372.5952885653724, 3409.829508524573, 5559.471850174237, 5621.325440947087, 5639.295088113986, 5644.407337229588, 5656.9999999999945, 5647.576431767613, 5672.801451949183, 5757.366689664133, 5764.855878603037, 5773.624714393551, 5044.596432285427, 5093.108705976458, 5112.514311140454, 5166.225066240057, 5199.740012999354, 5202.193659982709, 5282.973585132069, 5289.100852855005, 5296.682199068068, 5327.987682340362, 5121.590272778206, 5256.342957130359, 5262.657927234717, 5265.157574788034, 5292.973535132319, 5148.150555158394, 5153.742312884378, 5197.064528384889, 5212.921806172911, 5219.634625576211, 5169.638125331228, 5183.274341592142, 5217.399999000126, 5224.190250511177, 5235.293235413246, 5653.830385088454, 5658.547316214693, 5668.31980162379, 5682.659040457585, 5696.202531645573, 6105.572609917308, 6118.4668989547035, 6271.122042913996, 6281.780137695205, 6287.779927702509, 5155.40712818027, 6235.095911092912, 6237.064440333941, 6281.654509002003, 6325.304216536178, 5826.213461182686, 5830.854228644275, 5833.708314584296, 5835.824925252249, 5856.76572937082, 6195.380461953859, 6341.968290158612, 6352.872942541123, 6357.904631430532, 6374.235091788923, 5971.253593300838, 6015.939840601538, 6018.849528761729, 6099.420555047263, 6116.679772652678, 6102.09542342839, 6289.371062893674, 6294.339094395023, 6296.401841825019, 6305.148804911279, 6106.157323464342, 6108.0992441897915, 6121.296050954108, 6132.030754953331, 6166.414190651881, 6171.950768369298, 6259.405356491126, 6271.686415679198, 6273.592216505913, 6274.435300822948, 4853.757312134379, 4877.170880950247, 4899.2896030075435, 4926.679765815282, 4994.475580064113, 4445.533219012022, 4457.465104187453, 4463.285874260103, 4466.709663871903, 4523.36672865799, 4735.976320118446, 5792.681402522901, 5801.3328467225965, 5814.709264536757, 5823.708814559255, 6149.923763341398, 6215.595986260879, 6318.083877837687, 6328.17733694626, 6340.524460665469, 5688.744006519716, 5714.028615135437, 5725.0, 5744.454276843693, 5784.1902133701315, 5345.839624811262, 5401.351837779492, 5402.35171779389, 5427.375851777097, 5427.565794736412, 6243.125962365363, 6255.40573645503, 6329.335419780857, 6338.271098823602, 6339.936600633934, 6175.289841668266, 6203.0, 6207.627542347293, 6255.093011513214, 6298.527610429144, 6261.812145635638, 6287.056941458818, 6289.371062893674, 6291.245050593958, 6297.874042519033, 6231.9688401557705, 6242.5942313749465, 6249.218847644044, 6254.374562543891, 6268.373162683695, 6129.022607377628, 6164.137020816999, 6193.0, 6196.659183744757, 6219.937800622117, 6121.9595067255395, 6155.84610384744, 6159.137720719193, 6165.445109940127, 6183.0, 5981.312149102735, 6033.909491357545, 6121.265448146251, 6130.896438641087, 6145.784897528565, 4982.427020892499, 5659.801906933238, 5886.911696324473, 5936.436038576328, 5938.0, 6057.848553786014, 6103.267607886904, 6105.328413874559, 6109.0, 6112.419320164578, 5911.793087241926, 5913.319968203539, 5917.792877249276, 5924.822255332347, 5932.466078052823], "value": 5683.384576047609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.53025913568155, 466.5707549054869, 467.8105367326234, 485.7037207303544, 524.0750076115654, 37832.81083594581, 39709.43341515726, 39878.2024359513, 41840.163196736044, 41940.37089443653, 40155.996100097436, 40477.59522404775, 40538.72996510457, 40622.39066414006, 40726.185476290455, 8309.252167304941, 8539.786505337384, 9090.81818363634, 9308.953455232748, 9309.813803723922, 11107.333559986386, 11375.544978200904, 11391.145664075186, 11510.712232194179, 11550.53797848085, 9468.526573671323, 11259.437028148559, 11314.264572802782, 11323.150763692756, 11341.0, 11238.100951923867, 11296.491657875375, 11296.491657875415, 11307.717307067307, 11335.319880807096, 11102.833457498144, 11116.44417779116, 11199.496022678999, 11201.66395008151, 11207.327560346404, 38970.0, 39256.0, 39493.0, 39496.81509554718, 39498.80250598757, 3893.357595996657, 4007.7996100194873, 4053.5743746906446, 4082.081531655354, 4195.496540415139, 27220.0, 28093.578596321073, 28111.85944070287, 28134.718652813415, 28250.858745706344, 3115.2367669921014, 3270.2478429961243, 3291.1772056985756, 3306.8842590509216, 3309.9172520686934, 455131.0, 457142.0, 457354.71322643507, 457452.0, 458349.0, 53198.0, 53498.46501535013, 53505.464945350825, 53575.73212133914, 53582.73208633932, 56628.716856415456, 56747.0, 56776.0, 56785.716071420204, 56802.0, 15063.096214227182, 15301.617459563377, 15305.387784488496, 15312.234388280542, 15315.770263446057, 10666.093382062612, 10905.618303359344, 10922.399268040333, 11812.114091443176, 11850.525978960744, 17345.56636084083, 17896.731549026776, 17918.372856949944, 17922.28310867577, 17931.0, 6879.277675843964, 7748.597934640279, 7838.490498117604, 7857.7249796258, 7932.08780990182, 717.8277213468834, 818.6479813680056, 855.234565064264, 863.3999370437612, 869.1135042256863, 28741.56887646687, 28784.992525261514, 28835.855820721183, 29441.55837662437, 29532.557011644843, 1025.2259544044198, 1028.7890982348601, 1055.8996895294936, 1055.9102476289602, 1164.4352489042808, 11728.70678233051, 12834.743305133845, 13668.316584170752, 13746.862531374758, 13996.930015349859, 589325.0, 592783.0, 594060.0, 594081.0, 594484.0, 48584.514154858, 49107.50892491101, 49181.0, 49223.507764921895, 49289.767755806395, 1408.5281430720822, 1447.4065633090383, 1454.9742431585496, 1464.2532308522943, 1475.1370448287657, 24733.25800225996, 25875.932942646836, 26103.477930441666, 26313.4737305249, 26521.867390662923, 42049.78975105105, 44704.0, 44724.0, 44743.328850066624, 44820.55179448294, 553198.0, 553315.0, 558218.0, 559286.0, 559732.0, 23572.52854942857, 23949.760502394754, 23968.161114360915, 24002.159924402564, 24029.639555407033, 33644.83177584096, 39287.0, 41869.069165158144, 41874.79062604789, 43695.344569832116, 33310.50034249537, 33593.32813343768, 34680.30639387148, 35457.29085418329, 35546.46680299849, 29360.0, 32641.020769376955, 33252.50121248135, 33757.32485350328, 33825.0, 32421.35157296794, 33091.84178553835, 33161.0, 33235.50146747849, 33288.83355583207, 29801.403971920874, 29902.102936911928, 29959.70040299569, 30655.0, 30662.386752265276, 20428.897855510626, 20985.370438886857, 22581.887090564443, 23101.0, 23114.768852311263], "value": 19014.089162549917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.30014473224554, 395.2865078533246, 397.66397394201897, 403.270081153113, 422.2926597948436, 14281.571552853406, 16220.270087846045, 18562.0, 20964.532482726216, 21302.786972130274, 19885.40343789685, 20003.39989800305, 20383.490412739688, 22152.335429937128, 22555.774442255573, 5825.854353641151, 5826.737796799154, 5959.0, 5999.040153575429, 6057.787977420791, 5851.912221316684, 5946.167536544887, 5992.0712289595185, 5994.490468310199, 5998.790042348519, 4030.435738996543, 5951.732172052247, 6213.937860621404, 6488.383603557654, 6526.738930442777, 6405.203291021633, 6452.483801295885, 6597.373249541286, 6613.074169616258, 6631.237407698129, 5744.712764361765, 5745.741441635095, 5749.453801888814, 5752.395998420189, 5764.7117644117625, 20926.581468370547, 26110.0, 27299.454010919868, 27330.726692733017, 27591.0, 2694.353355194759, 2722.0, 2727.836329820217, 2769.5984082308155, 2775.5420355641295, 10384.065434110966, 13760.105593136414, 13829.861701382957, 16177.83822161775, 16186.75719864203, 1792.6325103353781, 1797.7842658880886, 1824.5438640339914, 1853.5736780540417, 1864.6177533605578, 122116.0, 122966.0, 125033.74966250312, 126898.36550817279, 127626.36186819099, 11463.770724585629, 11543.653690389301, 11689.707757306136, 11794.646160615195, 11873.050155987674, 15143.848561514464, 15578.143202123765, 15611.453599123975, 15613.0, 15618.375264989274, 8592.269657079218, 8779.165979231962, 8799.032106468283, 8842.336824738042, 8901.777455563533, 8470.872936905951, 8561.101084386175, 8577.656893724181, 8719.869201961976, 8755.124487551195, 4751.572358487683, 4784.425868895755, 4786.856394308176, 4797.0, 4851.078295123915, 1817.354839032151, 2009.4674911148556, 2010.095457044336, 2015.3550863723467, 2016.949576260576, 1004.5634742318408, 1018.8624535687735, 1019.56158851693, 1028.4343611014062, 1066.5068903535114, 22228.333150005525, 22477.4380640482, 22677.546449070927, 22680.206192783175, 22722.318330449783, 1051.574112484445, 1054.4991129213563, 1057.0740744409995, 1077.671310250381, 1077.8113830079706, 10745.946270268598, 11165.771765105832, 11615.825762613567, 11671.708207294716, 11674.94162529199, 639558.0, 702700.0, 708938.0, 718712.0, 726457.0, 114764.0, 115760.0, 130997.0, 139678.0, 147568.78646820306, 897.6095398501673, 971.523953262896, 993.4635296939572, 1125.831125331207, 1136.2387200575633, 16993.06538140414, 18940.768850024706, 20320.695189572463, 20689.27587534429, 20716.79283207209, 60296.69851650714, 60769.392306078145, 61139.08291375544, 61577.69211153915, 62230.68884655548, 89197.0, 89980.0, 91605.5419722897, 91614.08385916056, 92052.69868253348, 5884.499817515559, 7430.034095567542, 7503.624818759149, 8092.797680058045, 8675.86986195195, 12491.37543122822, 12653.608103108467, 12802.67993300175, 13688.863111368759, 13781.0, 10742.89257107419, 11247.943760281147, 11321.03771179459, 11588.420578970849, 11769.411529423665, 9712.465814380277, 11419.657410277705, 11490.827637585277, 11679.883201167879, 11828.876256755595, 10379.53292101842, 11306.434678265889, 11591.884081159418, 11599.478023488795, 11932.821007684717, 7442.367398771165, 7552.509086909334, 7588.203238660082, 7617.65720542588, 7678.270564296383, 8282.337413007066, 9287.86068208991, 10841.512131953923, 10931.398773067558, 11230.583044060557], "value": 10023.61046448481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.9072510286824, 1451.47746811148, 1455.3378212913126, 1472.0284612155979, 1476.8006319146912, 8035.9196408035905, 8453.408261421702, 8459.32325413967, 8465.407421480491, 8467.91532084679, 7366.484346095775, 7656.234376562355, 7656.885146722803, 7957.72147974821, 8194.426390152692, 2285.6228722260807, 2323.0939933425893, 2323.860568365895, 2325.732540757809, 2326.220716060122, 2316.224064938248, 2334.26470661741, 2341.203990643181, 2341.2390972933863, 2346.8122550195944, 1918.6450506656242, 1936.8741031832956, 2299.2527428585695, 2317.895694693734, 2322.8722420266877, 2247.8763667998337, 2269.1263863412705, 2279.2934190400947, 2297.7357603875603, 2306.630939049761, 1922.298361098203, 2283.8858057097245, 2315.351701523576, 2315.7452680205333, 2318.9304320870233, 8251.546164960924, 8401.41190116692, 8409.327253819742, 8414.83170336596, 8420.915790842075, 5005.174146265898, 5051.898962020739, 5178.766955487012, 5182.663126896739, 5192.091384007784, 2755.2423083651956, 3210.9197270068203, 3470.1845066409373, 3471.7222622190416, 3474.6699063588917, 1186.833843261944, 1189.6371606659966, 1207.7765613361555, 1228.0298564134412, 1240.6712221261373, 10693.251472396858, 10715.624953126604, 10723.410212438235, 10780.51487683056, 10807.02736753688, 3863.9613603864163, 4348.173846969065, 4632.652551058617, 4652.0, 4673.719576825401, 9327.554229094501, 9331.626734930662, 9337.112974267433, 9337.673181438617, 9354.251659867194, 5211.296474975906, 5218.921716174261, 5219.634625576173, 5225.608079394061, 5230.424653288135, 4280.636145927569, 4431.290993441034, 4459.9331010034875, 4661.766911654404, 4759.571638552547, 3737.6822970047306, 3784.7729136251914, 3820.9426858597144, 3885.2812229737588, 3889.591592882763, 1259.055708218836, 1259.5263541656284, 1266.3098611256887, 1274.6749578857332, 1282.5254655777421, 778.8948491953514, 848.4061157189992, 906.7823722306731, 912.8539433690711, 937.8546325319586, 5393.892122157535, 5458.153986132156, 5567.805126820542, 5706.971465142731, 5734.62724922887, 960.7165886063628, 987.3483500889522, 995.2286977592424, 1010.3988127064385, 1034.9689509314733, 3543.734219933464, 3638.4178531434845, 3639.745217834779, 3706.962930370662, 3857.2285542890972, 8279.461834980708, 9657.22742180624, 9970.50147492637, 9995.900040999497, 10006.54970526328, 9295.628174873065, 9778.07108324708, 9914.157296629868, 9932.453715045742, 9938.503074846374, 7581.279778421042, 7769.261920117579, 7774.922250777533, 7777.961110194526, 7779.72770953014, 4474.888127796831, 5512.779488820563, 5686.175504551899, 5736.913946290892, 5753.683547404933, 8746.562671866508, 8794.516301603473, 9093.136152065543, 9235.07649235071, 9238.30712696564, 9208.987011428871, 9238.399504032217, 9308.208802251884, 9338.299627527827, 9420.340576159602, 6572.934270657232, 6602.7689030883685, 6786.830329241809, 6999.30006999296, 7130.0, 7781.221877812173, 7881.566513841564, 7942.444028918151, 7958.880616790869, 7971.1630278819885, 5938.673372964528, 6995.020697102512, 7070.575765454089, 7103.396211321889, 7179.7128114876905, 6929.0, 6947.0, 6955.0, 6998.895016574857, 7009.9649501752165, 6192.0, 6237.095621134819, 6297.716602752796, 6383.616982981036, 6394.0, 4071.0, 4435.379046933367, 4930.9506904930495, 4972.65191436596, 5043.52086551777, 4868.464468908346, 4908.312836203006, 4972.105021096238, 5062.721550314768, 5171.767270472913], "value": 4365.845223834482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.4743893733746, 344.82241645552534, 358.6359844757571, 359.78952312896956, 374.7788804605282, 4510.0, 4652.790274528622, 4953.058918805429, 5260.92108618371, 5262.710720836434, 4126.133511962484, 4241.851535196269, 4295.787669350287, 4505.662075344346, 4939.925901111486, 3913.530376354834, 4055.878323650295, 4073.877783666495, 4155.296328505314, 4162.666986641061, 3764.5670747864074, 4089.6114869087537, 4098.585987834207, 4134.586541345871, 4143.0, 3642.8724994625195, 3978.0308747170047, 4104.01503639126, 4105.958940410603, 4111.917761644765, 3660.5607327120783, 3954.644082032602, 3970.563238043813, 3974.3839704845795, 3998.6001399860074, 3273.0, 3446.7414943879057, 3455.550778398792, 3458.87893923714, 3462.7056700180515, 5060.51925067118, 5087.287779710843, 5105.489451054865, 5112.846614601531, 5129.589632829365, 3894.2990261752875, 4308.181445525372, 4485.506594274627, 4576.604135738598, 4593.770311484446, 5051.368578927634, 5459.563234941195, 5553.7778488860395, 5559.360673522557, 5566.2207290979295, 3265.689759472846, 3775.6601905828607, 3812.066043819282, 3820.44603532489, 3820.522434695663, 4840.636952228597, 4963.071787645271, 5536.474034966672, 5584.5811564132855, 5774.97112514439, 3401.295969704091, 3752.193278445093, 3816.072883193969, 3839.731218814712, 3855.7443895321553, 3195.5526226328334, 3663.6735672847935, 3721.627837216257, 3893.824777885002, 3918.5885482024546, 4223.72545784523, 4264.0, 4495.303227999665, 4539.933115717804, 4568.0, 5006.3992320921725, 5190.325257716549, 5594.216809646653, 5651.434856514398, 5669.489745922887, 1265.7721610110268, 1265.9873401266054, 1268.1123213750411, 1277.8754695867576, 1286.9832832062752, 657.5430076097067, 810.4084018666289, 816.6243527977197, 844.5397258494136, 861.5046348349724, 4866.564363512773, 4908.312836202935, 4964.8758781030765, 4984.00639744098, 4986.401631804134, 4484.251142054602, 5255.527002569787, 5318.308619879391, 5365.919511207335, 5412.458754124635, 4520.88697782558, 4562.452505699337, 4748.881277968078, 4799.952000480021, 5315.548178404802, 2748.763056624527, 2755.9035433759723, 2802.1313392848283, 2825.4631619992138, 2860.284928767808, 5094.4141423736, 5263.0526705119355, 5559.19391688211, 5667.716614169358, 5701.828945131652, 4858.299595141672, 5022.397312322471, 5159.690418574897, 5217.6867689017745, 5274.123519213375, 4587.967707265839, 4840.643420921128, 5177.663451875616, 5437.32033495813, 5594.888102237933, 4743.291623305173, 4835.734034627989, 5128.948710512847, 5235.581153507786, 5375.919361209663, 4390.538993405647, 4953.563466594791, 4985.376827896513, 5456.727163641723, 5503.7066289422755, 4995.550400463976, 5465.808696695596, 5590.338328394908, 5698.686572238401, 5896.815719511415, 3226.951595726019, 3401.4727717203873, 3616.5298511193378, 3633.473146393811, 3766.717496187742, 4210.084411592779, 5201.635885488131, 5493.533933735958, 5696.458836410535, 5744.281964754406, 5020.748962551785, 5037.395512538519, 5553.972230138824, 5569.081101618188, 5682.147677848356, 5094.2867998479505, 5246.31797866275, 5520.889582208253, 5542.418046105101, 5669.6314739541795, 4129.938050929179, 4608.953910460852, 5399.757010934596, 5443.700596467233, 5495.835124946258, 4305.6986010978935, 5260.42343161452, 5380.385884234792, 5401.864953376197, 5403.378611459732, 4586.908261834811, 5379.273798037371, 5392.433794451683, 5404.459554044564, 5427.367726652491], "value": 3940.1109541509727, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.6725638949694, 726.4370113162295, 735.7376068589086, 772.2663469703783, 816.6651672814147, 14874.851251487482, 15886.046837189748, 15888.205589720526, 15915.44295949642, 15933.442329518455, 14404.423823047066, 14534.709305813878, 14735.410583576671, 14748.26258687064, 14748.483803066894, 680.5134328954796, 705.7776800307912, 727.7380143148463, 850.3834719828137, 884.1556313720414, 870.8214815962713, 876.3865294293988, 886.167003017165, 886.7738726624701, 886.835935351962, 940.1820416237848, 942.6936245720134, 942.9009953954838, 944.9527523623825, 945.229637845154, 728.6757392960135, 750.3846845586621, 937.7983733497263, 938.6714649872592, 939.9906000940006, 663.73450619752, 681.4786688183543, 688.9827754306133, 691.3915754136378, 693.549193024533, 14696.971212015163, 14750.336234869457, 15151.469698560497, 15156.1664108474, 15215.934884558086, 13467.191968481922, 13553.051286409955, 13599.52401665937, 13852.515161969282, 13913.930430347884, 10762.3542587445, 13035.0, 13107.016973727008, 13121.671958201026, 13492.12301200419, 3676.7977761223124, 4013.4180543821276, 4804.279358096313, 4871.342368780241, 4876.951230487721, 109952.90047099507, 110045.44977275142, 112425.43787281093, 112770.0, 113854.43072784666, 9691.176250018687, 10787.568497260021, 11730.589429369931, 11801.822972655416, 11895.252542836433, 23811.880940595533, 24228.51542969166, 24236.636450453258, 24244.272671819523, 24281.39296517566, 8092.878606820902, 8100.0, 8119.350451963829, 8314.127016663284, 8350.958245208734, 4296.5273819879785, 4355.716878402894, 4356.956430435718, 4361.1495758327455, 4361.323994780814, 3620.7827530348263, 3722.236941427055, 3726.1988672435555, 3734.9626503734617, 3743.513343265358, 603.4599033864666, 679.9218089919624, 684.0764967294213, 690.5407903743954, 700.2227527444533, 609.8353444569941, 613.9140520327157, 654.443722835586, 672.9703553563056, 708.4367927497651, 9298.410753684275, 9360.4383736976, 10189.05531838941, 10689.198310126772, 10751.354918704903, 573.5468979506227, 578.138573525444, 614.582084182751, 621.0373920423326, 724.3589423360364, 4440.489343725449, 4935.555799978019, 5020.347354843847, 5023.623228257895, 5159.25190847325, 71414.64292678607, 95783.04216957881, 95956.04043959471, 96239.0, 98007.0, 64899.0, 67828.0, 71311.75400363901, 81438.59280703559, 85839.5708021456, 70163.2983670167, 70596.0, 70822.0, 71900.0, 72883.0, 9727.756806079622, 9780.804383912424, 9798.65704700332, 9820.0, 9826.459544725109, 43188.784056079516, 46393.53606463892, 49227.75386123046, 49881.50118498768, 50395.992080158925, 62843.0, 64631.67684161549, 65099.67450162719, 65837.34162658504, 66939.0, 11615.535378584762, 11826.704332391759, 11864.466099025392, 11866.110041746731, 12143.33211673331, 12902.354882255662, 13063.085584009408, 13330.733385332433, 13359.332033398097, 13403.798943015667, 10507.31702439339, 10716.410597417216, 11950.223235489666, 12219.0, 12639.747205056032, 11409.087273017973, 13481.393337299649, 14018.649533761738, 14290.928545357207, 14432.206228657524, 13390.309133559475, 13688.726225475633, 13718.519851805138, 13867.167969921837, 13873.722525549634, 11348.546058157912, 11385.30677987988, 11513.251638643796, 11548.931366721963, 11564.363959982282, 9728.17310528613, 10438.425886576311, 11228.644399811485, 11374.772504550028, 11418.942905285421], "value": 7451.782390796338, "unit": "score"}], "name": "dromaeo_css", "value": 7196.124868886366, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 112.0, 110.0, 114.0, 111.0, 112.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 104.0, 144.0, 114.0, 117.0, 140.0, 100.0, 113.0, 132.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 181.0, 183.0, 183.0, 183.0, 184.0, 179.0, 190.0, 181.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 62.0, 88.0, 60.0, 58.0, 59.0, 59.0, 74.0, 52.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 68.0, 83.0, 68.0, 68.0, 69.0, 99.0, 95.0, 93.0, 83.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 85.0, 86.0, 84.0, 87.0, 85.0, 86.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 107.0, 148.0, 117.0, 93.0, 93.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 118.0, 85.0, 88.0, 87.0, 84.0, 87.0, 82.0, 88.0, 85.0], "value": 89.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 55.0, 55.0, 52.0, 56.0, 55.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 79.0, 70.0, 71.0, 68.0, 69.0, 68.0, 70.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 87.0, 87.0, 99.0, 108.0, 103.0, 89.0, 86.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 141.0, 139.0, 140.0, 144.0, 134.0, 159.0, 203.0, 142.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 173.0, 171.0, 170.0, 204.0, 171.0, 174.0, 174.0, 172.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 65.0, 66.0, 66.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1450.8000000000002, "alertThreshold": 2.0}]} 09:23:53 INFO - Return code: 0 09:23:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:53 INFO - # TBPL SUCCESS # 09:23:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:23:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:23:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:23:53 INFO - 2017-01-13 09:23:53.313 screenresolution[1646:10066] starting screenresolution argv=screenresolution get 09:23:53 INFO - 2017-01-13 09:23:53.317 screenresolution[1646:10066] Display 0: 1600x1200x32@60 09:23:53 INFO - 2017-01-13 09:23:53.323 screenresolution[1647:10069] starting screenresolution argv=screenresolution list 09:23:53 INFO - Available Modes on Display 0 09:23:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:23:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:23:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:23:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:23:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:23:53 INFO - Intel Iris: 09:23:53 INFO - Chipset Model: Intel Iris 09:23:53 INFO - Type: GPU 09:23:53 INFO - Bus: Built-In 09:23:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:23:53 INFO - Vendor: Intel (0x8086) 09:23:53 INFO - Device ID: 0x0a2e 09:23:53 INFO - Revision ID: 0x0009 09:23:53 INFO - Displays: 09:23:53 INFO - Display: 09:23:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:23:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:23:53 INFO - Display Serial Number: 1600x1200 60 09:23:53 INFO - Main Display: Yes 09:23:53 INFO - Mirror: Off 09:23:53 INFO - Online: Yes 09:23:53 INFO - Rotation: Supported 09:23:53 INFO - Return code: 0 09:23:53 INFO - Running post-action listener: _resource_record_post_action 09:23:53 INFO - [mozharness: 2017-01-13 17:23:53.562819Z] Finished run-tests step (success) 09:23:53 INFO - Running post-run listener: _resource_record_post_run 09:23:53 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39101440; Write bytes: 554487808; Read time: 382; Write time: 1871 09:23:53 INFO - TinderboxPrint: CPU usage
53.7% 09:23:53 INFO - TinderboxPrint: I/O read bytes / time
39,101,440 / 382 09:23:53 INFO - TinderboxPrint: I/O write bytes / time
554,487,808 / 1,871 09:23:53 INFO - TinderboxPrint: CPU idle
2,225.8 (46.3%) 09:23:53 INFO - TinderboxPrint: CPU system
958.1 (19.9%) 09:23:53 INFO - TinderboxPrint: CPU user
1,621.8 (33.7%) 09:23:53 INFO - TinderboxPrint: Swap in / out
290,435,072 / 0 09:23:53 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252889600; Write bytes: 252628992; Read time: 18186; Write time: 464 09:23:53 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34563072; Write bytes: 300265472; Read time: 345; Write time: 1400 09:23:54 INFO - Running post-run listener: _upload_blobber_files 09:23:54 INFO - Blob upload gear active. 09:23:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:54 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 09:23:54 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:23:54 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:23:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:56 INFO - (blobuploader) - INFO - Done attempting. 09:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:57 INFO - (blobuploader) - INFO - Done attempting. 09:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:23:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:58 INFO - (blobuploader) - INFO - Done attempting. 09:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:01 INFO - (blobuploader) - INFO - Done attempting. 09:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:01 INFO - Return code: 0 09:24:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9db8f0d021c736ca497e3c61c073357856f88e888cdca65cd6a99d015de1361fad050a5e881ab08018167ba07367401babae138a2b6a52b90f1150c80a915af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bcdf815eaa05289670860ad84302215bb557cbd34b2021842787252fbeb54467f600609bf679caae26564536b1d93f4a9d00f47fb145bf4c9ec2a8dd4f19ad03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0925208e6ec429d0c7536cef730bd5a2f23c378e02ca13e5d416983fccd7d383d87ecdcc21a099af2e28477f0aeb36a2da7bb2630f25f09a488f85043d1fad67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1086464677db8e81f01304af5e2f755dd51a038b5e8ae10495b9a7eff872625d0e69d82ea0633c70dd5963a405e50d577610bb05c4b886d94b698ac1055d261f"} 09:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:01 INFO - Contents: 09:24:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9db8f0d021c736ca497e3c61c073357856f88e888cdca65cd6a99d015de1361fad050a5e881ab08018167ba07367401babae138a2b6a52b90f1150c80a915af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bcdf815eaa05289670860ad84302215bb557cbd34b2021842787252fbeb54467f600609bf679caae26564536b1d93f4a9d00f47fb145bf4c9ec2a8dd4f19ad03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0925208e6ec429d0c7536cef730bd5a2f23c378e02ca13e5d416983fccd7d383d87ecdcc21a099af2e28477f0aeb36a2da7bb2630f25f09a488f85043d1fad67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1086464677db8e81f01304af5e2f755dd51a038b5e8ae10495b9a7eff872625d0e69d82ea0633c70dd5963a405e50d577610bb05c4b886d94b698ac1055d261f"} 09:24:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:01 INFO - Copying logs to upload dir... 09:24:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.576978 ========= master_lag: 0.79 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-13 09:24:01.829982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 09:24:01.833825) ========= 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.y3opqosfTf/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.tF4MOXVArC/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9db8f0d021c736ca497e3c61c073357856f88e888cdca65cd6a99d015de1361fad050a5e881ab08018167ba07367401babae138a2b6a52b90f1150c80a915af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bcdf815eaa05289670860ad84302215bb557cbd34b2021842787252fbeb54467f600609bf679caae26564536b1d93f4a9d00f47fb145bf4c9ec2a8dd4f19ad03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0925208e6ec429d0c7536cef730bd5a2f23c378e02ca13e5d416983fccd7d383d87ecdcc21a099af2e28477f0aeb36a2da7bb2630f25f09a488f85043d1fad67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1086464677db8e81f01304af5e2f755dd51a038b5e8ae10495b9a7eff872625d0e69d82ea0633c70dd5963a405e50d577610bb05c4b886d94b698ac1055d261f"} build_url:https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/PhPiWANYQZCgRzkfvA2fxg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9db8f0d021c736ca497e3c61c073357856f88e888cdca65cd6a99d015de1361fad050a5e881ab08018167ba07367401babae138a2b6a52b90f1150c80a915af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/bcdf815eaa05289670860ad84302215bb557cbd34b2021842787252fbeb54467f600609bf679caae26564536b1d93f4a9d00f47fb145bf4c9ec2a8dd4f19ad03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0925208e6ec429d0c7536cef730bd5a2f23c378e02ca13e5d416983fccd7d383d87ecdcc21a099af2e28477f0aeb36a2da7bb2630f25f09a488f85043d1fad67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1086464677db8e81f01304af5e2f755dd51a038b5e8ae10495b9a7eff872625d0e69d82ea0633c70dd5963a405e50d577610bb05c4b886d94b698ac1055d261f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 09:24:01.868477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:24:01.868799) ========= 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.y3opqosfTf/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.tF4MOXVArC/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005216 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 09:24:01.917413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 09:24:01.917727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 09:24:01.918049) ========= ========= Total master_lag: 0.93 =========