builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0141 starttime: 1491069189.25 results: success (0) buildid: 20170401101422 builduid: 679d99b4562343d29bcc876b43af76db revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.255299) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.256049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.256320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.405166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.405413) ========= 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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-01 10:53:09-- 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% 14.4M=0.001s 2017-04-01 10:53:09 (14.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.492047 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.929267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.930442) ========= 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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.027206 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.982459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:09.982757) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-01 10:53:10,084 truncating revision to first 12 chars 2017-04-01 10:53:10,084 Setting DEBUG logging. 2017-04-01 10:53:10,084 attempt 1/10 2017-04-01 10:53:10,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a3f514cf849?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 10:53:10,727 unpacking tar archive at: mozilla-central-7a3f514cf849/testing/mozharness/ program finished with exit code 0 elapsedTime=0.915807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.923034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.923379) ========= script_repo_revision: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.923813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.924136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 10:53:10.948864) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-01 10:53:10.949450) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:53:11 INFO - MultiFileLogger online at 20170401 10:53:11 in /builds/slave/test 10:53:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:53:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:11 INFO - {'append_to_log': False, 10:53:11 INFO - 'base_work_dir': '/builds/slave/test', 10:53:11 INFO - 'blob_upload_branch': 'Firefox', 10:53:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:11 INFO - 'branch': 'Firefox', 10:53:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:11 INFO - 'config_files': ('talos/mac_config.py',), 10:53:11 INFO - 'default_actions': ('clobber', 10:53:11 INFO - 'read-buildbot-config', 10:53:11 INFO - 'download-and-extract', 10:53:11 INFO - 'populate-webroot', 10:53:11 INFO - 'create-virtualenv', 10:53:11 INFO - 'install', 10:53:11 INFO - 'run-tests'), 10:53:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:11 INFO - 'download_minidump_stackwalk': True, 10:53:11 INFO - 'download_symbols': 'ondemand', 10:53:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:11 INFO - 'gecko_profile': False, 10:53:11 INFO - 'gecko_profile_interval': 0, 10:53:11 INFO - 'installer_path': 'installer.exe', 10:53:11 INFO - 'log_level': 'info', 10:53:11 INFO - 'log_name': 'talos', 10:53:11 INFO - 'log_to_console': True, 10:53:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:53:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:53:11 INFO - 'opt_config_files': (), 10:53:11 INFO - 'pip_index': False, 10:53:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:11 INFO - 'cmd': ('bash', 10:53:11 INFO - '-c', 10:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:11 INFO - 'enabled': True, 10:53:11 INFO - 'halt_on_failure': False, 10:53:11 INFO - 'name': 'check_screen_resolution'},), 10:53:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:11 INFO - 'cmd': ('bash', 10:53:11 INFO - '-c', 10:53:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:11 INFO - 'enabled': True, 10:53:11 INFO - 'halt_on_failure': False, 10:53:11 INFO - 'name': 'check_screen_resolution'},), 10:53:11 INFO - 'run_cmd_checks_enabled': True, 10:53:11 INFO - 'suite': 'dromaeojs', 10:53:11 INFO - 'system_bits': '32', 10:53:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:11 INFO - 'title': 't-yosemite-r7-0141', 10:53:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:11 INFO - 'use_talos_json': True, 10:53:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:11 INFO - 'work_dir': 'build'} 10:53:11 INFO - [mozharness: 2017-04-01 17:53:11.168525Z] Running clobber step. 10:53:11 INFO - Running pre-action listener: _resource_record_pre_action 10:53:11 INFO - Running main action method: clobber 10:53:11 INFO - rmtree: /builds/slave/test/build 10:53:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:13 INFO - Running post-action listener: _resource_record_post_action 10:53:13 INFO - [mozharness: 2017-04-01 17:53:13.734449Z] Finished clobber step (success) 10:53:13 INFO - [mozharness: 2017-04-01 17:53:13.734606Z] Running read-buildbot-config step. 10:53:13 INFO - Running pre-action listener: _resource_record_pre_action 10:53:13 INFO - Running main action method: read_buildbot_config 10:53:13 INFO - Using buildbot properties: 10:53:13 INFO - { 10:53:13 INFO - "project": "", 10:53:13 INFO - "product": "firefox", 10:53:13 INFO - "script_repo_revision": "production", 10:53:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:53:13 INFO - "repository": "", 10:53:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:53:13 INFO - "buildid": "20170401101422", 10:53:13 INFO - "pgo_build": "False", 10:53:13 INFO - "basedir": "/builds/slave/test", 10:53:13 INFO - "buildnumber": 17, 10:53:13 INFO - "slavename": "t-yosemite-r7-0141", 10:53:13 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:53:13 INFO - "platform": "yosemite_r7", 10:53:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:53:13 INFO - "branch": "mozilla-central", 10:53:13 INFO - "repo_path": "mozilla-central", 10:53:13 INFO - "revision": "7a3f514cf8490d271ee373a1d2999e4ea4dee2d7", 10:53:13 INFO - "stage_platform": "macosx64", 10:53:13 INFO - "builduid": "679d99b4562343d29bcc876b43af76db", 10:53:13 INFO - "slavebuilddir": "test" 10:53:13 INFO - } 10:53:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:53:13 INFO - Running post-action listener: _resource_record_post_action 10:53:13 INFO - [mozharness: 2017-04-01 17:53:13.737901Z] Finished read-buildbot-config step (success) 10:53:13 INFO - [mozharness: 2017-04-01 17:53:13.738014Z] Running download-and-extract step. 10:53:13 INFO - Running pre-action listener: _resource_record_pre_action 10:53:13 INFO - Running main action method: download_and_extract 10:53:13 INFO - mkdir: /builds/slave/test/build/tests 10:53: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')]} 10:53:13 INFO - trying https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:53:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:53:14 INFO - Downloaded 1325 bytes. 10:53:14 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:53:14 INFO - Using the following test package requirements: 10:53:14 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:53:14 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:53:14 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:53:14 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:53:14 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'jsshell-mac.zip'], 10:53:14 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:53:14 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:53:14 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:53:14 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:53:14 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:53:14 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:53:14 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:53:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:53:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:53:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:53:16 INFO - Expected file size: 52516226 10:53:16 INFO - Obtained file size: 52516226 10:53:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:53:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:53:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:32 INFO - Fetch https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:53:33 INFO - Expected file size: 52516226 10:53:33 INFO - Obtained file size: 52516226 10:53:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:53:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:53:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:53:49 INFO - Expected file size: 14404152 10:53:49 INFO - Obtained file size: 14404152 10:53: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')]} 10:53:50 INFO - trying https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:53:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:53:52 INFO - Downloaded 75593154 bytes. 10:53:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:53:52 INFO - mkdir: /builds/slave/test/properties 10:53:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:52 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:52 INFO - Contents: 10:53:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:53:53 INFO - Running post-action listener: _resource_record_post_action 10:53:53 INFO - Running post-action listener: set_extra_try_arguments 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.042490Z] Finished download-and-extract step (success) 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.042623Z] Running populate-webroot step. 10:53:53 INFO - Running pre-action listener: _resource_record_pre_action 10:53:53 INFO - Running main action method: populate_webroot 10:53:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:53 INFO - '--tppagecycles', 10:53:53 INFO - '7'], 10:53:53 INFO - 'tests': ['tsvgm']}}, 10:53:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['damp', 'tps']}, 10:53:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'tests': ['damp', 'tps']}, 10:53:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['dromaeo_dom']}, 10:53:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['basic_compositor_video']}, 10:53:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:53:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['a11yr', 10:53:53 INFO - 'ts_paint', 10:53:53 INFO - 'tpaint', 10:53:53 INFO - 'sessionrestore', 10:53:53 INFO - 'sessionrestore_no_auto_restore', 10:53:53 INFO - 'tabpaint']}, 10:53:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tsvgx', 10:53:53 INFO - 'tsvgr_opacity', 10:53:53 INFO - 'tart', 10:53:53 INFO - 'tscrollx', 10:53:53 INFO - 'cart', 10:53:53 INFO - 'tsvg_static']}, 10:53:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:53 INFO - 'tsvgr_opacity', 10:53:53 INFO - 'tart', 10:53:53 INFO - 'tscrollx', 10:53:53 INFO - 'cart', 10:53:53 INFO - 'tsvg_static']}, 10:53:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s'], 10:53:53 INFO - 'tests': ['tp5o']}, 10:53:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:53:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--disable-e10s', 10:53:53 INFO - '--xperf_path', 10:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:53 INFO - 'tests': ['tp5n']}, 10:53:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:53:53 INFO - 'talos_options': ['--xperf_path', 10:53:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:53 INFO - 'tests': ['tp5n']}}, 10:53:53 INFO - 'talos.zip': {'path': '', 10:53:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:53 INFO - Running post-action listener: _resource_record_post_action 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.060899Z] Finished populate-webroot step (success) 10:53:53 INFO - [mozharness: 2017-04-01 17:53:53.061031Z] Running create-virtualenv step. 10:53:53 INFO - Running pre-action listener: _resource_record_pre_action 10:53:53 INFO - Running main action method: create_virtualenv 10:53:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:53:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:53 INFO - Using real prefix '/tools/python27' 10:53:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:56 INFO - Installing pip.................done. 10:53:56 INFO - Return code: 0 10:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:53:57 INFO - Reading from file tmpfile_stdout 10:53:57 INFO - Output received: 10:53:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:53:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 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 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:57 INFO - 'HOME': '/Users/cltbld', 10:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:57 INFO - 'LOGNAME': 'cltbld', 10:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:57 INFO - 'MOZ_NO_REMOTE': '1', 10:53:57 INFO - 'NO_EM_RESTART': '1', 10:53:57 INFO - 'PAGER': '/bin/cat', 10:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:57 INFO - 'PWD': '/builds/slave/test', 10:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:57 INFO - 'SHELL': '/bin/bash', 10:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:53:57 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:57 INFO - 'USER': 'cltbld', 10:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:57 INFO - 'XPC_FLAGS': '0x0', 10:53:57 INFO - 'XPC_SERVICE_NAME': '0', 10:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:57 INFO - Cleaning up... 10:53:57 INFO - Return code: 0 10:53:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 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 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:57 INFO - 'HOME': '/Users/cltbld', 10:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:57 INFO - 'LOGNAME': 'cltbld', 10:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:57 INFO - 'MOZ_NO_REMOTE': '1', 10:53:57 INFO - 'NO_EM_RESTART': '1', 10:53:57 INFO - 'PAGER': '/bin/cat', 10:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:57 INFO - 'PWD': '/builds/slave/test', 10:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:57 INFO - 'SHELL': '/bin/bash', 10:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:53:57 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:57 INFO - 'USER': 'cltbld', 10:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:57 INFO - 'XPC_FLAGS': '0x0', 10:53:57 INFO - 'XPC_SERVICE_NAME': '0', 10:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:57 INFO - Downloading/unpacking psutil>=3.1.1 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:01 INFO - Installing collected packages: psutil 10:54:01 INFO - Running setup.py install for psutil 10:54:01 INFO - building 'psutil._psutil_osx' extension 10:54:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:54:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:54:02 INFO - building 'psutil._psutil_posix' extension 10:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:54:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:54:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:54:02 INFO - ^ 10:54:02 INFO - 1 warning generated. 10:54:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:02 INFO - Successfully installed psutil 10:54:02 INFO - Cleaning up... 10:54:02 INFO - Return code: 0 10:54:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:54:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:02 INFO - 'HOME': '/Users/cltbld', 10:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:02 INFO - 'LOGNAME': 'cltbld', 10:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:02 INFO - 'MOZ_NO_REMOTE': '1', 10:54:02 INFO - 'NO_EM_RESTART': '1', 10:54:02 INFO - 'PAGER': '/bin/cat', 10:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:02 INFO - 'PWD': '/builds/slave/test', 10:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:02 INFO - 'SHELL': '/bin/bash', 10:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:02 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:02 INFO - 'USER': 'cltbld', 10:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:02 INFO - 'XPC_FLAGS': '0x0', 10:54:02 INFO - 'XPC_SERVICE_NAME': '0', 10:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:05 INFO - Installing collected packages: mozsystemmonitor 10:54:05 INFO - Running setup.py install for mozsystemmonitor 10:54:05 INFO - Successfully installed mozsystemmonitor 10:54:05 INFO - Cleaning up... 10:54:05 INFO - Return code: 0 10:54:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:54:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:05 INFO - 'HOME': '/Users/cltbld', 10:54:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:05 INFO - 'LOGNAME': 'cltbld', 10:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:05 INFO - 'MOZ_NO_REMOTE': '1', 10:54:05 INFO - 'NO_EM_RESTART': '1', 10:54:05 INFO - 'PAGER': '/bin/cat', 10:54:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:05 INFO - 'PWD': '/builds/slave/test', 10:54:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:05 INFO - 'SHELL': '/bin/bash', 10:54:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:05 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:05 INFO - 'USER': 'cltbld', 10:54:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:05 INFO - 'XPC_FLAGS': '0x0', 10:54:05 INFO - 'XPC_SERVICE_NAME': '0', 10:54:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:06 INFO - Downloading/unpacking jsonschema==2.5.1 10:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:09 INFO - warning: no files found matching '*.txt' 10:54:09 INFO - no previously-included directories found matching 'build' 10:54:09 INFO - no previously-included directories found matching 'dist' 10:54:09 INFO - no previously-included directories found matching '.git*' 10:54:09 INFO - Installing collected packages: jsonschema, functools32 10:54:09 INFO - Running setup.py install for functools32 10:54:09 INFO - warning: no files found matching '*.txt' 10:54:09 INFO - no previously-included directories found matching 'build' 10:54:09 INFO - no previously-included directories found matching 'dist' 10:54:09 INFO - no previously-included directories found matching '.git*' 10:54:09 INFO - Successfully installed jsonschema functools32 10:54:09 INFO - Cleaning up... 10:54:09 INFO - Return code: 0 10:54:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:09 INFO - 'HOME': '/Users/cltbld', 10:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:09 INFO - 'LOGNAME': 'cltbld', 10:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:09 INFO - 'MOZ_NO_REMOTE': '1', 10:54:09 INFO - 'NO_EM_RESTART': '1', 10:54:09 INFO - 'PAGER': '/bin/cat', 10:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:09 INFO - 'PWD': '/builds/slave/test', 10:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:09 INFO - 'SHELL': '/bin/bash', 10:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:09 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:09 INFO - 'USER': 'cltbld', 10:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:09 INFO - 'XPC_FLAGS': '0x0', 10:54:09 INFO - 'XPC_SERVICE_NAME': '0', 10:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:54:09 INFO - Cleaning up... 10:54:09 INFO - Return code: 0 10:54:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:09 INFO - 'HOME': '/Users/cltbld', 10:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:09 INFO - 'LOGNAME': 'cltbld', 10:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:09 INFO - 'MOZ_NO_REMOTE': '1', 10:54:09 INFO - 'NO_EM_RESTART': '1', 10:54:09 INFO - 'PAGER': '/bin/cat', 10:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:09 INFO - 'PWD': '/builds/slave/test', 10:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:09 INFO - 'SHELL': '/bin/bash', 10:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:09 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:09 INFO - 'USER': 'cltbld', 10:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:09 INFO - 'XPC_FLAGS': '0x0', 10:54:09 INFO - 'XPC_SERVICE_NAME': '0', 10:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - Downloading docopt-0.6.1.tar.gz 10:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:14 INFO - Running setup.py install for blobuploader 10:54:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:14 INFO - Running setup.py install for requests 10:54:14 INFO - Running setup.py install for docopt 10:54:14 INFO - Successfully installed blobuploader requests docopt 10:54:14 INFO - Cleaning up... 10:54:14 INFO - Return code: 0 10:54:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:14 INFO - 'HOME': '/Users/cltbld', 10:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:14 INFO - 'LOGNAME': 'cltbld', 10:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:14 INFO - 'MOZ_NO_REMOTE': '1', 10:54:14 INFO - 'NO_EM_RESTART': '1', 10:54:14 INFO - 'PAGER': '/bin/cat', 10:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:14 INFO - 'PWD': '/builds/slave/test', 10:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:14 INFO - 'SHELL': '/bin/bash', 10:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:14 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:14 INFO - 'USER': 'cltbld', 10:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:14 INFO - 'XPC_FLAGS': '0x0', 10:54:14 INFO - 'XPC_SERVICE_NAME': '0', 10:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-syfuR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Ow1OYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-rUEAuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Kzhmfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-7dKkxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-DNP4ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-BlnDJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:15 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-degwVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-brfsds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-rfTJ_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Vv98Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-6uxNwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-kkB9BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-5ZmryB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-0k9Eiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-bsyVyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:16 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-sxqvdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:16 INFO - Running setup.py install for manifestparser 10:54:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozcrash 10:54:17 INFO - Running setup.py install for mozdebug 10:54:17 INFO - Running setup.py install for mozdevice 10:54:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozfile 10:54:17 INFO - Running setup.py install for mozhttpd 10:54:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozinfo 10:54:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:17 INFO - Running setup.py install for mozInstall 10:54:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for mozleak 10:54:18 INFO - Running setup.py install for mozlog 10:54:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for moznetwork 10:54:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for mozprocess 10:54:18 INFO - Running setup.py install for mozprofile 10:54:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:18 INFO - Running setup.py install for mozrunner 10:54:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:19 INFO - Running setup.py install for mozscreenshot 10:54:19 INFO - Running setup.py install for moztest 10:54:19 INFO - Running setup.py install for mozversion 10:54:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:19 INFO - Cleaning up... 10:54:19 INFO - Return code: 0 10:54:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:19 INFO - 'HOME': '/Users/cltbld', 10:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:19 INFO - 'LOGNAME': 'cltbld', 10:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:19 INFO - 'MOZ_NO_REMOTE': '1', 10:54:19 INFO - 'NO_EM_RESTART': '1', 10:54:19 INFO - 'PAGER': '/bin/cat', 10:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:19 INFO - 'PWD': '/builds/slave/test', 10:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:19 INFO - 'SHELL': '/bin/bash', 10:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:19 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:19 INFO - 'USER': 'cltbld', 10:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:19 INFO - 'XPC_FLAGS': '0x0', 10:54:19 INFO - 'XPC_SERVICE_NAME': '0', 10:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-YWmzzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:19 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-VmB3SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-CkuBL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-RCmaQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-FRwnBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-zXHaC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-m6cSnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-vINVoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Mag8v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-A2Si2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-6RUM4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:54:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:20 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-NTbKoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:21 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-sH9duF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:21 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-SuhPIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:21 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-BmAK_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:21 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-985bdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:54:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:21 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-xcskSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:24 INFO - Downloading blessings-1.6.tar.gz 10:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:24 INFO - Installing collected packages: blessings 10:54:24 INFO - Running setup.py install for blessings 10:54:24 INFO - Successfully installed blessings 10:54:24 INFO - Cleaning up... 10:54:24 INFO - Return code: 0 10:54:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:24 INFO - Reading from file tmpfile_stdout 10:54:24 INFO - Current package versions: 10:54:24 INFO - blessings == 1.6 10:54:24 INFO - blobuploader == 1.2.4 10:54:24 INFO - docopt == 0.6.1 10:54:24 INFO - functools32 == 3.2.3-2 10:54:24 INFO - jsonschema == 2.5.1 10:54:24 INFO - manifestparser == 1.1 10:54:24 INFO - mozInstall == 1.12 10:54:24 INFO - mozcrash == 1.0 10:54:24 INFO - mozdebug == 0.1 10:54:24 INFO - mozdevice == 0.49 10:54:24 INFO - mozfile == 1.2 10:54:24 INFO - mozhttpd == 0.7 10:54:24 INFO - mozinfo == 0.9 10:54:24 INFO - mozleak == 0.1 10:54:24 INFO - mozlog == 3.4 10:54:24 INFO - moznetwork == 0.27 10:54:24 INFO - mozprocess == 0.25 10:54:24 INFO - mozprofile == 0.28 10:54:24 INFO - mozrunner == 6.13 10:54:24 INFO - mozscreenshot == 0.1 10:54:24 INFO - mozsystemmonitor == 0.3 10:54:24 INFO - moztest == 0.8 10:54:24 INFO - mozversion == 1.4 10:54:24 INFO - psutil == 3.1.1 10:54:24 INFO - requests == 1.2.3 10:54:24 INFO - wsgiref == 0.1.2 10:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:24 INFO - 'HOME': '/Users/cltbld', 10:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:24 INFO - 'LOGNAME': 'cltbld', 10:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:24 INFO - 'MOZ_NO_REMOTE': '1', 10:54:24 INFO - 'NO_EM_RESTART': '1', 10:54:24 INFO - 'PAGER': '/bin/cat', 10:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:24 INFO - 'PWD': '/builds/slave/test', 10:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:24 INFO - 'SHELL': '/bin/bash', 10:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:24 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:24 INFO - 'USER': 'cltbld', 10:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:24 INFO - 'XPC_FLAGS': '0x0', 10:54:24 INFO - 'XPC_SERVICE_NAME': '0', 10:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:54:25 INFO - Cleaning up... 10:54:25 INFO - Return code: 0 10:54:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036c5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036c8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89805bcff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, '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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:25 INFO - 'HOME': '/Users/cltbld', 10:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:25 INFO - 'LOGNAME': 'cltbld', 10:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:25 INFO - 'MOZ_NO_REMOTE': '1', 10:54:25 INFO - 'NO_EM_RESTART': '1', 10:54:25 INFO - 'PAGER': '/bin/cat', 10:54:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:25 INFO - 'PWD': '/builds/slave/test', 10:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:25 INFO - 'SHELL': '/bin/bash', 10:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:25 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:25 INFO - 'USER': 'cltbld', 10:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:25 INFO - 'XPC_FLAGS': '0x0', 10:54:25 INFO - 'XPC_SERVICE_NAME': '0', 10:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:54:25 INFO - Cleaning up... 10:54:25 INFO - Return code: 0 10:54:25 INFO - Running post-action listener: _resource_record_post_action 10:54:25 INFO - Running post-action listener: _start_resource_monitoring 10:54:25 INFO - Starting resource monitoring. 10:54:25 INFO - [mozharness: 2017-04-01 17:54:25.413559Z] Finished create-virtualenv step (success) 10:54:25 INFO - [mozharness: 2017-04-01 17:54:25.414503Z] Running install step. 10:54:25 INFO - Running pre-action listener: _resource_record_pre_action 10:54:25 INFO - Running main action method: install 10:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:25 INFO - Reading from file tmpfile_stdout 10:54:25 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:25 INFO - Reading from file tmpfile_stdout 10:54:25 INFO - Output received: 10:54:25 INFO - Usage: mozinstall [options] installer 10:54:25 INFO - Options: 10:54:25 INFO - -h, --help show this help message and exit 10:54:25 INFO - -d DEST, --destination=DEST 10:54:25 INFO - Directory to install application into. [default: 10:54:25 INFO - "/builds/slave/test"] 10:54:25 INFO - --app=APP Application being installed. [default: firefox] 10:54:25 INFO - mkdir: /builds/slave/test/build/application 10:54:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:54:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:54:46 INFO - Reading from file tmpfile_stdout 10:54:46 INFO - Output received: 10:54:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:54:46 INFO - Running post-action listener: _resource_record_post_action 10:54:46 INFO - [mozharness: 2017-04-01 17:54:46.417084Z] Finished install step (success) 10:54:46 INFO - [mozharness: 2017-04-01 17:54:46.417217Z] Running run-tests step. 10:54:46 INFO - Running pre-action listener: _resource_record_pre_action 10:54:46 INFO - Running main action method: run_tests 10:54:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:46 INFO - 2017-04-01 10:54:46.432 screenresolution[1640:10903] starting screenresolution argv=screenresolution get 10:54:46 INFO - 2017-04-01 10:54:46.434 screenresolution[1640:10903] Display 0: 1600x1200x32@60 10:54:46 INFO - 2017-04-01 10:54:46.440 screenresolution[1641:10906] starting screenresolution argv=screenresolution list 10:54:46 INFO - Available Modes on Display 0 10:54:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:46 INFO - Intel Iris: 10:54:46 INFO - Chipset Model: Intel Iris 10:54:46 INFO - Type: GPU 10:54:46 INFO - Bus: Built-In 10:54:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:46 INFO - Vendor: Intel (0x8086) 10:54:46 INFO - Device ID: 0x0a2e 10:54:46 INFO - Revision ID: 0x0009 10:54:46 INFO - Displays: 10:54:46 INFO - Display: 10:54:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:46 INFO - Display Serial Number: 1600x1200 60 10:54:46 INFO - Main Display: Yes 10:54:46 INFO - Mirror: Off 10:54:46 INFO - Online: Yes 10:54:46 INFO - Rotation: Supported 10:54:46 INFO - Return code: 0 10:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:46 INFO - Python 2.7.3 10:54:46 INFO - Return code: 0 10:54:46 INFO - grabbing minidump binary from tooltool 10:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:46 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 0x1034a3d30>, '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 0x1033cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:54:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:54:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:54:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:46 INFO - Return code: 0 10:54:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:46 INFO - ENV: RUST_BACKTRACE is now 1 10:54:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HX2fsCm9Hs/Render', 10:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:46 INFO - 'HOME': '/Users/cltbld', 10:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:46 INFO - 'LOGNAME': 'cltbld', 10:54:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:46 INFO - 'MOZ_NO_REMOTE': '1', 10:54:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:46 INFO - 'NO_EM_RESTART': '1', 10:54:46 INFO - 'PAGER': '/bin/cat', 10:54:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:46 INFO - 'PWD': '/builds/slave/test', 10:54:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:46 INFO - 'RUST_BACKTRACE': '1', 10:54:46 INFO - 'SHELL': '/bin/bash', 10:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cZMXL8SRkp/Listeners', 10:54:46 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 10:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:46 INFO - 'USER': 'cltbld', 10:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:46 INFO - 'XPC_FLAGS': '0x0', 10:54:46 INFO - 'XPC_SERVICE_NAME': '0', 10:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:54:47 INFO - mozversion application_buildid: 20170401101422 10:54:47 INFO - mozversion application_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 10:54:47 INFO - mozversion application_display_name: Nightly 10:54:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:47 INFO - mozversion application_name: Firefox 10:54:47 INFO - mozversion application_remotingname: firefox 10:54:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:54:47 INFO - mozversion application_vendor: Mozilla 10:54:47 INFO - mozversion application_version: 55.0a1 10:54:47 INFO - mozversion platform_buildid: 20170401101422 10:54:47 INFO - mozversion platform_changeset: 7a3f514cf8490d271ee373a1d2999e4ea4dee2d7 10:54:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:54:47 INFO - mozversion platform_version: 55.0a1 10:54:47 INFO - using testdate: 1491069287 10:54:47 INFO - actual date: 1491069287 10:54:47 INFO - starting webserver on 'localhost:49244' 10:54:47 INFO - SUITE-START | Running 2 tests 10:54:47 INFO - TEST-START | dromaeo_css 10:54:47 INFO - operating with platform_type : mac_ 10:54:47 INFO - Initialising browser for dromaeo_css test... 10:54:47 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpDyZAef/profile http://localhost:49244/getInfo.html) 10:54:49 INFO - PID 1651 | __metrics Screen width/height:1600/1200 10:54:49 INFO - PID 1651 | colorDepth:24 10:54:49 INFO - PID 1651 | Browser inner width/height: 1024/689 10:54:49 INFO - PID 1651 | __metrics 10:54:49 INFO - PID 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:54:49 INFO - PID 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:50 INFO - TEST-INFO | 1651: exit 0 10:54:50 INFO - Browser initialized. 10:54:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:50 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpDyZAef/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:02 INFO - PID 1654 | RSS: Main: 232996864 10:55:02 INFO - PID 1654 | 10:58:08 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 10:58:10 INFO - PID 1654 | RSS: Main: 422240256 10:58:10 INFO - PID 1654 | 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 10:59:52 INFO - PID 1654 | 10:59:52 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:52 INFO - PID 1654 | Full stack: 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 10:59:52 INFO - PID 1654 | 10:59:52 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:52 INFO - PID 1654 | Full stack: 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 10:59:52 INFO - PID 1654 | 10:59:52 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:52 INFO - PID 1654 | Full stack: 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | ************************* 10:59:52 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 10:59:52 INFO - PID 1654 | 10:59:52 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:52 INFO - PID 1654 | Full stack: 10:59:52 INFO - PID 1654 | ************************* 11:01:13 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 11:01:13 INFO - PID 1654 | RSS: Main: 372420608 11:01:13 INFO - PID 1654 | 11:04:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 11:04:17 INFO - PID 1654 | RSS: Main: 332800000 11:04:17 INFO - PID 1654 | 11:07:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 11:07:19 INFO - PID 1654 | RSS: Main: 338219008 11:07:19 INFO - PID 1654 | 11:10:23 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 11:10:24 INFO - PID 1654 | RSS: Main: 337920000 11:10:24 INFO - PID 1654 | 11:13:27 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 11:13:28 INFO - PID 1654 | RSS: Main: 439926784 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | __start_tp_report 11:13:28 INFO - PID 1654 | _x_x_mozilla_page_load 11:13:28 INFO - PID 1654 | _x_x_mozilla_page_load_details 11:13:28 INFO - PID 1654 | |i|pagename|runs| 11:13:28 INFO - PID 1654 | |0;dojo.html;3554.0937061049435;3578.069701877511;3582.7312951528643;3588.049166970753;3633.981830090851;5123.564497017749;6131.325554189036;6266.811995640127;6310.274318453374;6317.115603815464;6156.076588511725;6200.441960223579;6253.499720022399;6256.718447669854;6264.342244064376;4610.792514336863;5261.000409922121;5453.727313634322;5474.069408200616;5487.149491828753;5538.806141785039;5562.833115006556;5576.275084239043;5578.470045345706;5610.66336019838;5305.283786688786;5393.649412788156;5402.810901618424;5408.107662235727;5498.642588231792;5494.423085575997;5501.697406642633;5543.833684989457;5546.833594992157;5560.833175004756;5411.594130440233;5427.158790387457;5431.728413579305;5438.646487978269;5439.700816455093;6265.216847894013;6268.1851359323455;6272.6236425814595;6275.905861412082;6291.402316779944;6218.968905155445;6278.4663303619245;6306.905396419057;6307.810765676991;6587.374199451045;6732.29310922351;6756.628385438799;6781.830454238634;6783.59298442095;6800.217974932847;6324.462420694293;6345.587536810092;6375.10748495211;6408.070829729663;6416.615003099829;6605.801825945133;6677.332266773284;6689.03009063683;6944.826379340456;6958.756443524554;6295.520552670119;6417.422431981144;6510.446612037935;6519.967400162969;6551.770688025897;6013.1581578579035;6758.5269031167345;6823.112995310677;6825.180978282638;6825.897611535831;6330.525210609223;6684.632345220963;6690.598564086073;6711.429528490133;6711.563748356341;6418.069379939882;6419.903701444482;6430.196225471816;6448.645324507103;6549.312322206195;5349.144136938071;5366.248725178478;5387.4073851876265;5387.515123638891;5393.5954803389905;4761.761911904391;4774.9522504775205;4776.498467660915;4782.736949467743;4785.353977213102;6248.156498872685;6386.07401926718;6392.4246817786625;6394.488440924715;6419.422251997343;6533.24867640218;6545.312742162099;6559.868802623921;6570.704318305688;6572.934270657328;6315.210598675166;6319;6323.27282362525;6326.051092336094;6333.081703153017;5956.76172953077;5977.701114944235;6002.339742628395;6021.5182785377065;6042.758289668364;6941.132358455193;6998.825029374307;7005.05431766705;7008.5094043416475;7016.298370162943;6469.708863101266;6522.28254891971;6802.523823332517;6831;6834.350736680008;6745.966270168814;6907.13660792401;6983.162020557363;6992.265812089658;7007.544509606859;6670.76652317186;6675.7997260082275;6679.8664026718225;6690.163729533809;6690.230623478362;6422.678866056585;6762.459003279628;6765.729370825112;6772.424343930821;6795.3204679531655;6357;6357.713902874474;6442.774502892376;6469.838254043687;6502.739890404331;6519;6533.085368048382;6552.705128269144;6557.344265573404;6561.278259391559;4906.8773280668265;5417.864553386197;6308.936910630835;6404.7438102477245;6435.131257280207;5529.253550770594;6324.747010119544;6366.9681651591445;6372.107904893226;6544.476441884733;5664.291963504562;6346.143270658402;6351.364863513611;6381.585196962183;6384.872302554016 11:13:28 INFO - PID 1654 | |1;ext.html;738.2469880721665;796.2873228460527;815.2214635023553;1129.9999999999995;1152.8847115288477;28612.141635750933;37637;38149.23701525968;38194.42708359377;38238.808805956;40491.392629110516;40840.59159408405;40859;40881.18237635253;40884.182316353654;6145.231846019247;8519.57402129894;8717.825643487127;8722.38943273971;8752.431091979033;6168.691565421734;7296.197418283985;8488.278496327819;8620.224179823814;8625.266852317529;8642.783930401727;8690.478571285743;8699.52152631605;8714.172153645426;8735.956320218422;8636.611352489123;8675.305975522006;8698.173673501007;8698.478091314479;8709.651613935435;8464.1112683168;8530.274926631244;8533.591957327033;8533.74398768038;8538.27424668904;37894.81052594747;38125.428118578246;38176.854694359216;38214.23571528582;38343.42484862729;2951.940961180764;3018.4566777979953;3022.5163973764093;3034.286942568495;3066.739327157194;26460.60309095365;26697.866510667518;26733.19800405991;26867;27149.321266968287;2785.220138361262;2822.393185465135;2830.6603207615217;2874.3101655602713;2883.4665586866495;315082;315525;315737.8475260088;316347.4182629072;317405.9999999977;48059.519404805505;48100;48125.75937120292;48292.758536207795;48352.164783521366;50415;50450.4864854055;50453;50470.74764626153;50619.24071138936;14049.578512644433;14438.783418248735;14473.203973781332;14479.92760036193;14491.710165796625;10033.899661003297;10200.97990200974;11692.766144677229;11710;11798.292102473879;11763.294202347886;13242.735145297233;13456.461741530426;13540.729185416236;13582.45670173182;5757.366689664133;5865.149553314745;5929.584929055011;5931.110333450017;5954.434328738763;941.6346297868118;971.7424882406168;981.1954197557934;984.2224642532319;1026.825439675242;24004.39989000254;24067;24069.879650601633;24153.275401737978;24157.275281741575;1077.902988731018;1084.1760262200785;1132.4620805117504;1141.7145713571608;1146.529922731676;12118.515259389525;12286.692832679075;12311.630651080482;12332.260064396165;12346.75306493883;484416;487825;488479;490035;490443;55171;55549;55595.166072508946;55696;55847.72076139593;1442.0986883198002;1481.2445652716976;1526.7862499250336;1532.7470967290494;1543.2129613896768;19276.903615482395;20594.485137871674;23643.763562364846;23691.52616947686;23744.050237990978;38539.6146038536;38573;38628.80685596554;38652;38709.99999999887;400410;400756;401738;401750;402380;27443.588346175224;33502.99491015273;33768.49347259744;33856.83071584626;34056;42665;44026.899327515785;44117.77941110274;44179.337309939736;44231.77884110559;25344.619830702184;27931.882724690786;30022.3995520084;30103.698963010967;30272.243193920327;29097;29493.26266843346;30147.246318842204;30262.69737302599;30385.24036899095;35590.64409355873;35718.92843214708;36174.63825361818;36190.45714314235;36519.08702282358;28940.42119157647;29797.255068623457;30375;30387.074520468297;30527.931522396608;23640.645390318816;23712;23712.932918019076;23950;24374.756252437957 11:13:28 INFO - PID 1654 | |2;jquery.html;381.92108283531866;424.5070436185832;434.94345735054446;436.93664418659296;454.48189064466516;11998.640040798779;22363.776362236393;22483.887580562096;23363.1822886199;23418;20057.29799457019;22052.88973555134;22722.431939201528;22831.657525137136;23015.964281607325;4592.839250626229;5246.37043554773;5537.750801213935;6410.2628197757385;6442.516811239152;3777.2067865748227;3956.940645890314;3957.9604203958024;6233.968830155843;6417.775377861776;6105.481034112106;6364.968175159118;6377.681115944208;6381.457576106037;6385.457236134934;6072.392760723937;6197.566170368076;6269.2476902771505;6280.340564240781;6355.142055822451;5570.303712035996;5573.136163894603;5581.246531718207;5581.609287349887;5588.776448942038;25328.873355633288;28168;29204.8539757302;29388.559171612444;29488.70511294881;1990.4028791362678;2018.9192432302837;2028.5334373094272;2058.5574101568236;2075.408508575049;15561.37754489819;16113.27490262941;16719.66560668792;17109.31562737489;17627.206775695126;1847.9168437420215;1865.9533511662182;1867.1411150870615;1899.8736733211947;1905.8380037696813;138156.30921845426;151392;161494;161500;166436;9982.201423886072;10056.899431005597;12538;12598.307093109966;12803.871961280269;16535.25591348392;16561.337546498246;16593.087380193963;16600.83399166017;16605.6678866422;8620.137986201455;8892.466452012899;8926.642934282685;9074.500902450296;9077.77305567366;8225.670973161126;8476.321894248445;8491.405601607952;8613.181747733955;8636.395452318277;6494.6752662367635;7777.183395743478;7907.327877130393;7928.524288542706;7957.403194760416;2061.3506745375157;2126.2983215538834;2154.978450215509;2182.8144607708523;2311.202635090891;849.3926842307656;910.349100393222;918.8284936705753;938.1462868789368;946.7301818981557;18244;20664;20680.069396877177;20725.68911466329;20728.58542829165;931.6552875435997;945.6737425588299;960.2845879819439;976.7460460280379;985.8225519406433;9052.27581793455;10091.949540252399;10545.261831671864;10571.596232457674;10743.623973161059;714422;715279;722536;723612.7290453237;747720;157464;157865.2106739482;159748;160234;161500.19249903676;1139.2651739627893;1150.1546363422879;1180.9704757380962;1181.5923506390282;1223.902087832989;20181.39455816328;21373.114629525437;21462.46343841354;21467.745886681674;21570.892145539172;59692.70153649204;60367;60369;60444.39555604388;60816.39183608107;82400;83720;84969;86197;86683;7834;8258.380621453534;8360.916390836257;8406.95796521038;8658.567071646266;12547.3098979557;12577.622671319876;12621.432035558239;12863.807042894177;12864;10907.345559266469;10970.451477426257;11166.832497512381;11279.830802537805;11400.657980260605;9974.301798874008;10116.595336186765;10186.592536298465;10367.688969330931;10380.688579342632;11186.049185819296;11627.6511704649;11817.936385725327;12044.156909016636;12072.818907716215;6687.933120668926;6887.242403335529;8235.723462863265;8358.87461688063;8618.569071546523;9344.972053074292;11188.832167517656;11347.375894325562;11484.540618375171;11567.768644626893 11:13:28 INFO - PID 1654 | |3;mootools.html;1354.8848347890428;1409.6969151632397;1424.1526291856349;1442.632128807154;1443.1629654800217;10249.436281004542;10743.15306443793;10746.946265268663;10748.516316765745;10761.569537218511;10374.325668831521;10545.42000189991;10738.08726258269;10744.301620394668;10753.30103543269;2382.95234095318;2453.766892145243;2456.385903524119;2457.9016839326496;2458.373114855718;2286.0969916882823;2443.657887895696;2465.963010554843;2467.037855236459;2472.1223965492263;2056.064490656755;2140.283005193262;2143.0463443767453;2371;2459.6187590923437;2417.7944874685672;2442.120836498859;2446.22943772711;2448.204333591581;2450.7426720194303;2405.1461731085387;2416.32342943976;2427.963580546293;2457.5207834472285;2460.2250291158407;10686.625968091079;10766.569337226501;10772.784544309148;10802.783944321069;10803.621873234399;6096.939030609726;6327.746890124389;6339.0808332791485;6342.016987366919;6348.428641422248;3347.96652033479;3758.32350176968;3785.205106927521;3985.0236692010644;4011.5587285398583;1152.1704372851534;1155.3587758793867;1187.7921363761393;1208.3354155214597;1216.0697066743949;14752.041117327339;14897.180655063967;15120.924395378062;15143.394264229528;15222.010569312959;5322;5607.579431542651;5626.465485778845;5629.605927585029;5696.405006598159;12638.747225055447;12641.557545486048;12646.683832904251;12652.620421387373;12668.809967850306;6349.6507692077375;6353.30113687494;6353.30113687494;6358.650274234869;6364;5622.57830662702;5697.4302569742695;5802;5831.912521312183;5855.502282305966;4237.237297286518;4368.934465983013;4382.255016647177;4431.113777244564;4435;1229.3914512316283;1353.3301015996947;1356.0643156222175;1393.5749596373203;1415.186267895964;735.88961655751;750.9549427034395;774.6436639145943;780.8165081205912;808.3694718119876;6065.332813390523;6734.730610775514;6955.547889387173;7013.403860671798;7014.508984371045;838.9580520973927;850.4089657687848;899.0829354058824;908.4413085952092;933.5332333833084;4006.6794656427414;4035.1526179502634;4099.344104943195;4113.876583702494;4252.298370768788;13205.933970330087;13768.862311376959;13785.793213101811;13795.586132415843;13804.516841910485;13662.795058074136;13672;13696.863031369758;13698.726025479435;13705.931470342784;9715;10135.594576217016;10143.543540540693;10149.746256343502;10167.847482287772;5172.5603323717905;5783.306003279633;5965.582409231486;6408.263049749152;6782.599166122901;12064.215825971283;12135.878641213474;12252.326122063372;12356.073294502768;12449.564265250672;12311.938440307742;12321;12459.875401246234;12548.874511255135;12570.497180112692;8901.465912045298;9181.219596334386;9205.723828285161;9212.585433655635;9253.58358873839;9909.207263419054;9950.35322704022;10094.141997929964;10096.798064038825;10133.442660653734;7097.751578694721;8380.24577788002;8444.408891377545;8484.321254299764;8687.956560217159;8352.6241319142;8383.916160838313;8431.40980131385;8508.74473765788;8532.872006920024;7600.125985511737;7644.694212231449;7680.5391676499585;7734.419918506247;7778.261065198797;5871.089981052944;5908.202392676933;5909.763609455574;5917.201177841109;5988.910166347421;5859.150423188699;5917.1715959766525;5931.258592675916;5949.672767997802;6008.459238668541 11:13:28 INFO - PID 1654 | |4;prototype.html;308.4678928847738;388.97893030794165;393.75980651802394;406.07009947220865;406.932856078747;5505.054795684309;5513.173024046395;6064.757409703612;6144.723487443064;6183.474404675602;4990.5259000395;5454.127339625651;5661.3206415230125;5885.764569417218;5994.3215899548195;4050.9392359114636;4171.955741686582;4188.97370144315;4458.66560007999;4458.97770511147;3664.3404187246283;3771.0949372150762;4480.790186649602;4493.752843593601;4497.820087196525;3661.2677464507074;4216.409702641633;4333.1766964276685;4405.88985275369;4435.68950173488;4399.758013309267;4406.030673251879;4425.977870110661;4455.1535208310315;4456.353828694837;3811.8284677189595;3818.083659921627;3827.1771569112498;3838.157684311518;3840.711946604016;5125.615578831603;5741.799037033684;5832.591718579701;5926.851828704273;5942.97028514859;4614.077184563101;5145.562627176657;5320.467953204688;5329.493698098674;5354.571634269249;5296.629235953485;6406.487481001509;6494.350564943515;6494.90257646131;6517.087607734921;3655.5613326400735;4158.625723684883;4302.784860756981;4359.847405340798;4372.89067773305;6546.545045607897;6740.662966851638;6743.022261772016;6812.284710105467;6900.965495172542;3681.815909204529;4288.89277768052;4395.033092719596;4417.160739459492;4431.556844315543;3725.441183822394;4495.685302028892;4495.797689103998;4516.503184649686;4521.412216411845;4733.408323959505;4974.825881094144;5126.79492820283;5186.714730689849;5302.363716353985;5577.470140336662;6327.4373878579245;6459.289478157399;6466.960528551574;6469.676516174172;1282.224254326138;1497.6929729405663;1497.9470758108594;1530.778037184602;1543.1589783567983;951.8048799995984;957.8314456363225;980.3823591137681;1007.5717819926648;1012.5595366015659;4705.788239529229;4891.730954797449;5200.141976573898;6188.452886778306;6218;5826.970865145647;5858.882822343615;6265.404786545362;6725.764598239038;6742.730290788411;5447.782088716486;5562.694051827189;6291.5281353898645;6327.145835312174;6374.58565193261;3382.1251935854325;3541.256336169382;3564.2891412122326;3567.501649307297;3568.8044505091084;5699.943000570024;6442.840288748071;6667.366600172976;6721.1598550181225;6839.110915581042;5091.137963245092;5167.379914410295;6622.304658010839;7002.859942801116;7010.92989070113;5670.432956704297;5817.040188368872;5915.438033386908;7069.8939515907305;7079.159418551214;5540.418256083214;5595;6799.218089919525;6829.453643708392;6829.6243706596615;5294.564500329891;5815.476607105381;5913.6747478887355;6655.900161497679;6732.562383445061;6411.4229719325485;6983.406410455168;6992.79021629352;7026.894596581157;7308.342249197598;4400.163968845909;4433.534478879671;4443.400140980926;4447.933281000723;4459;6498.415142637185;6764.797056088325;6766.391024807791;6797.320267973361;6834.965825170842;6422.550421470452;6518.185226846645;6537.771178008747;6538;6541.215054193337;5073.822416215415;6327.2283760547125;6537.411632952867;6540.607563546202;6558.213014438298;5241.868953276198;5494.587905907153;6314.273858506147;6314.905276420949;6397.6481293529305;6240.843978900564;6530.444912182327;6533.967330163318;6539.607623542603;6570.441512471493;4983.8504844854715;6283.183186185949;6365.077063825812;6377.8724425512155;6432.2602900667025 11:13:28 INFO - PID 1654 | |5;yui.html;653.5686446945017;731.010168411198;731.4514114414189;737.0946352027257;745.8955746195534;15648.921755391235;16491.58771030725;16558.834411655895;16560.171991400442;16611.66776664466;14516.274186290697;14522.128672279645;14542.418303267883;14544.927275363634;16875.493735187963;896.2068569316153;937.7421209167466;944.6032666280145;945.1446440970898;945.3288165402538;972.9270304727174;975.9951200243988;977.1791694976218;977.9926675524222;979.7158823941048;992.6773798515475;1025.2361990317224;1030.361176070837;1030.469308306223;1030.6959446963126;1016.7508960304773;1019.133736324126;1019.8521214423866;1020.4948550467492;1020.6019652335596;766.9616519174019;767.0373681030327;768.2202564397086;768.9577073260969;769.0425420351698;16252.268647910872;16607.91696041524;16779;16946.06796626185;17259.827401725946;14984.100953942689;15033.398664053424;15075.54773356801;15109.924450377788;16083.839161608352;11537.88462115385;11924.582639607659;11940.761184776256;12060.939695301555;12315.5073797048;3036.5748795168693;3067.6318841739135;3126.89055883043;3133.4359815233247;3174.6349169845535;104158.4376234357;110555.78888422187;117720.8227917727;117824;119625.80374196234;11517.366544840113;11647.534098635959;11661.067114630809;11716.589919352782;11979.401029948467;25487.617685734727;25489.362765931;25500.617490737655;25513.662677344895;25514.300426438433;7953.562554059582;8003.4797738146835;8069;8154.633041513146;8350.039745429232;3506.8421921013614;4066.674666026711;4164.562720914321;4208.516020657664;4215.114825886537;4152.294110001307;4218.578142185818;4233.343831706091;4244.193603215379;4260.0840819223395;828.0849661124491;828.8135169586915;839.2404873589411;839.8320335932716;848.4315508609246;536.4126281721509;553.532265235875;556.5325126893429;577.8988676981595;580.6864293281665;9725.173360264314;9737;10198.592056317813;10256.692299231036;10308.278420510493;519.9220116982407;524.79270688078;531.4446403508343;562.3420597900466;583.988320233593;4391.121775644884;4668.229742092584;4695.652173913043;4697.929531056969;4851.636127290467;105683.41474877883;107304.46347768212;108318.45840770745;108605;109552.35671464934;78562.03594910173;95581.52209238909;97206.0279397197;97483;97841.51079244558;76616.61691691617;77798;79282.6035869817;79631.60184199158;82294.76557851637;7953.761387158394;8651.351148663749;9356.111169438893;9370.203532699525;9399.906000940176;23737.762622373557;41312.586874132074;41419.96450088772;41539.58460415357;41572.25849673544;52657.736711316196;52688;53675;53832.46167538274;54421;11196.160287978597;11863.110266729856;11990;12224.144309898222;12415.93792031034;12864.549740759028;12875.227486350848;12890.985845542587;13001.804972925225;13108.803367949298;11936.224145430519;11994.520219191134;12057.336846473529;12100.432797181307;12442.129050966345;11814.881851181379;11928.105392095455;11992.695412679413;12052.879471205175;12350.135490515937;11466.31202127875;11779.05767538612;11926.4688356571;12132.150749447806;12394.75210495803;8800.427972181787;8833.64665413402;8915.910840891507;8975.596098175467;9112.95443522778;9028.909710902806;9915;9943.552540135855;9951.950240248752;9958.651447199314 11:13:28 INFO - PID 1654 | __end_tp_report 11:13:28 INFO - PID 1654 | __start_cc_report 11:13:28 INFO - PID 1654 | _x_x_mozilla_cycle_collect,2008 11:13:28 INFO - PID 1654 | __end_cc_report 11:13:28 INFO - PID 1654 | __startTimestamp1491070408184__endTimestamp 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | ------- Summary: start ------- 11:13:28 INFO - PID 1654 | Number of tests: 6 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | [#0] dojo.html Cycles:165 Average:6135.60 Median:6351.36 stddev:722.74 (11.4%) stddev-sans-first:696.00 11:13:28 INFO - PID 1654 | Values: 3554.1 3578.1 3582.7 3588.0 3634.0 5123.6 6131.3 6266.8 6310.3 6317.1 6156.1 6200.4 6253.5 6256.7 6264.3 4610.8 5261.0 5453.7 5474.1 5487.1 5538.8 5562.8 5576.3 5578.5 5610.7 5305.3 5393.6 5402.8 5408.1 5498.6 5494.4 5501.7 5543.8 5546.8 5560.8 5411.6 5427.2 5431.7 5438.6 5439.7 6265.2 6268.2 6272.6 6275.9 6291.4 6219.0 6278.5 6306.9 6307.8 6587.4 6732.3 6756.6 6781.8 6783.6 6800.2 6324.5 6345.6 6375.1 6408.1 6416.6 6605.8 6677.3 6689.0 6944.8 6958.8 6295.5 6417.4 6510.4 6520.0 6551.8 6013.2 6758.5 6823.1 6825.2 6825.9 6330.5 6684.6 6690.6 6711.4 6711.6 6418.1 6419.9 6430.2 6448.6 6549.3 5349.1 5366.2 5387.4 5387.5 5393.6 4761.8 4775.0 4776.5 4782.7 4785.4 6248.2 6386.1 6392.4 6394.5 6419.4 6533.2 6545.3 6559.9 6570.7 6572.9 6315.2 6319.0 6323.3 6326.1 6333.1 5956.8 5977.7 6002.3 6021.5 6042.8 6941.1 6998.8 7005.1 7008.5 7016.3 6469.7 6522.3 6802.5 6831.0 6834.4 6746.0 6907.1 6983.2 6992.3 7007.5 6670.8 6675.8 6679.9 6690.2 6690.2 6422.7 6762.5 6765.7 6772.4 6795.3 6357.0 6357.7 6442.8 6469.8 6502.7 6519.0 6533.1 6552.7 6557.3 6561.3 4906.9 5417.9 6308.9 6404.7 6435.1 5529.3 6324.7 6367.0 6372.1 6544.5 5664.3 6346.1 6351.4 6381.6 6384.9 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | [#1] ext.html Cycles:180 Average:53351.60 Median:35946.78 stddev:108460.39 (301.7%) stddev-sans-first:108692.71 11:13:28 INFO - PID 1654 | Values: 738.2 796.3 815.2 1130.0 1152.9 28612.1 37637.0 38149.2 38194.4 38238.8 40491.4 40840.6 40859.0 40881.2 40884.2 6145.2 8519.6 8717.8 8722.4 8752.4 6168.7 7296.2 8488.3 8620.2 8625.3 8642.8 8690.5 8699.5 8714.2 8736.0 8636.6 8675.3 8698.2 8698.5 8709.7 8464.1 8530.3 8533.6 8533.7 8538.3 37894.8 38125.4 38176.9 38214.2 38343.4 2951.9 3018.5 3022.5 3034.3 3066.7 26460.6 26697.9 26733.2 26867.0 27149.3 2785.2 2822.4 2830.7 2874.3 2883.5 315082.0 315525.0 315737.8 316347.4 317406.0 48059.5 48100.0 48125.8 48292.8 48352.2 50415.0 50450.5 50453.0 50470.7 50619.2 14049.6 14438.8 14473.2 14479.9 14491.7 10033.9 10201.0 11692.8 11710.0 11798.3 11763.3 13242.7 13456.5 13540.7 13582.5 5757.4 5865.1 5929.6 5931.1 5954.4 941.6 971.7 981.2 984.2 1026.8 24004.4 24067.0 24069.9 24153.3 24157.3 1077.9 1084.2 1132.5 1141.7 1146.5 12118.5 12286.7 12311.6 12332.3 12346.8 484416.0 487825.0 488479.0 490035.0 490443.0 55171.0 55549.0 55595.2 55696.0 55847.7 1442.1 1481.2 1526.8 1532.7 1543.2 19276.9 20594.5 23643.8 23691.5 23744.1 38539.6 38573.0 38628.8 38652.0 38710.0 400410.0 400756.0 401738.0 401750.0 402380.0 27443.6 33503.0 33768.5 33856.8 34056.0 42665.0 44026.9 44117.8 44179.3 44231.8 25344.6 27931.9 30022.4 30103.7 30272.2 29097.0 29493.3 30147.2 30262.7 30385.2 35590.6 35718.9 36174.6 36190.5 36519.1 28940.4 29797.3 30375.0 30387.1 30527.9 23640.6 23712.0 23712.9 23950.0 24374.8 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | [#2] jquery.html Cycles:180 Average:41351.96 Median:24373.44 stddev:121555.45 (498.7%) stddev-sans-first:121857.52 11:13:28 INFO - PID 1654 | Values: 381.9 424.5 434.9 436.9 454.5 11998.6 22363.8 22483.9 23363.2 23418.0 20057.3 22052.9 22722.4 22831.7 23016.0 4592.8 5246.4 5537.8 6410.3 6442.5 3777.2 3956.9 3958.0 6234.0 6417.8 6105.5 6365.0 6377.7 6381.5 6385.5 6072.4 6197.6 6269.2 6280.3 6355.1 5570.3 5573.1 5581.2 5581.6 5588.8 25328.9 28168.0 29204.9 29388.6 29488.7 1990.4 2018.9 2028.5 2058.6 2075.4 15561.4 16113.3 16719.7 17109.3 17627.2 1847.9 1866.0 1867.1 1899.9 1905.8 138156.3 151392.0 161494.0 161500.0 166436.0 9982.2 10056.9 12538.0 12598.3 12803.9 16535.3 16561.3 16593.1 16600.8 16605.7 8620.1 8892.5 8926.6 9074.5 9077.8 8225.7 8476.3 8491.4 8613.2 8636.4 6494.7 7777.2 7907.3 7928.5 7957.4 2061.4 2126.3 2155.0 2182.8 2311.2 849.4 910.3 918.8 938.1 946.7 18244.0 20664.0 20680.1 20725.7 20728.6 931.7 945.7 960.3 976.7 985.8 9052.3 10091.9 10545.3 10571.6 10743.6 714422.0 715279.0 722536.0 723612.7 747720.0 157464.0 157865.2 159748.0 160234.0 161500.2 1139.3 1150.2 1181.0 1181.6 1223.9 20181.4 21373.1 21462.5 21467.7 21570.9 59692.7 60367.0 60369.0 60444.4 60816.4 82400.0 83720.0 84969.0 86197.0 86683.0 7834.0 8258.4 8360.9 8407.0 8658.6 12547.3 12577.6 12621.4 12863.8 12864.0 10907.3 10970.5 11166.8 11279.8 11400.7 9974.3 10116.6 10186.6 10367.7 10380.7 11186.0 11627.7 11817.9 12044.2 12072.8 6687.9 6887.2 8235.7 8358.9 8618.6 9345.0 11188.8 11347.4 11484.5 11567.8 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | [#3] mootools.html Cycles:180 Average:6772.90 Median:2469.58 stddev:4170.64 (168.9%) stddev-sans-first:4162.47 11:13:28 INFO - PID 1654 | Values: 1354.9 1409.7 1424.2 1442.6 1443.2 10249.4 10743.2 10746.9 10748.5 10761.6 10374.3 10545.4 10738.1 10744.3 10753.3 2383.0 2453.8 2456.4 2457.9 2458.4 2286.1 2443.7 2466.0 2467.0 2472.1 2056.1 2140.3 2143.0 2371.0 2459.6 2417.8 2442.1 2446.2 2448.2 2450.7 2405.1 2416.3 2428.0 2457.5 2460.2 10686.6 10766.6 10772.8 10802.8 10803.6 6096.9 6327.7 6339.1 6342.0 6348.4 3348.0 3758.3 3785.2 3985.0 4011.6 1152.2 1155.4 1187.8 1208.3 1216.1 14752.0 14897.2 15120.9 15143.4 15222.0 5322.0 5607.6 5626.5 5629.6 5696.4 12638.7 12641.6 12646.7 12652.6 12668.8 6349.7 6353.3 6353.3 6358.7 6364.0 5622.6 5697.4 5802.0 5831.9 5855.5 4237.2 4368.9 4382.3 4431.1 4435.0 1229.4 1353.3 1356.1 1393.6 1415.2 735.9 751.0 774.6 780.8 808.4 6065.3 6734.7 6955.5 7013.4 7014.5 839.0 850.4 899.1 908.4 933.5 4006.7 4035.2 4099.3 4113.9 4252.3 13205.9 13768.9 13785.8 13795.6 13804.5 13662.8 13672.0 13696.9 13698.7 13705.9 9715.0 10135.6 10143.5 10149.7 10167.8 5172.6 5783.3 5965.6 6408.3 6782.6 12064.2 12135.9 12252.3 12356.1 12449.6 12311.9 12321.0 12459.9 12548.9 12570.5 8901.5 9181.2 9205.7 9212.6 9253.6 9909.2 9950.4 10094.1 10096.8 10133.4 7097.8 8380.2 8444.4 8484.3 8688.0 8352.6 8383.9 8431.4 8508.7 8532.9 7600.1 7644.7 7680.5 7734.4 7778.3 5871.1 5908.2 5909.8 5917.2 5988.9 5859.2 5917.2 5931.3 5949.7 6008.5 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | [#4] prototype.html Cycles:180 Average:5142.90 Median:5570.08 stddev:1634.54 (29.3%) stddev-sans-first:1598.35 11:13:28 INFO - PID 1654 | Values: 308.5 389.0 393.8 406.1 406.9 5505.1 5513.2 6064.8 6144.7 6183.5 4990.5 5454.1 5661.3 5885.8 5994.3 4050.9 4172.0 4189.0 4458.7 4459.0 3664.3 3771.1 4480.8 4493.8 4497.8 3661.3 4216.4 4333.2 4405.9 4435.7 4399.8 4406.0 4426.0 4455.2 4456.4 3811.8 3818.1 3827.2 3838.2 3840.7 5125.6 5741.8 5832.6 5926.9 5943.0 4614.1 5145.6 5320.5 5329.5 5354.6 5296.6 6406.5 6494.4 6494.9 6517.1 3655.6 4158.6 4302.8 4359.8 4372.9 6546.5 6740.7 6743.0 6812.3 6901.0 3681.8 4288.9 4395.0 4417.2 4431.6 3725.4 4495.7 4495.8 4516.5 4521.4 4733.4 4974.8 5126.8 5186.7 5302.4 5577.5 6327.4 6459.3 6467.0 6469.7 1282.2 1497.7 1497.9 1530.8 1543.2 951.8 957.8 980.4 1007.6 1012.6 4705.8 4891.7 5200.1 6188.5 6218.0 5827.0 5858.9 6265.4 6725.8 6742.7 5447.8 5562.7 6291.5 6327.1 6374.6 3382.1 3541.3 3564.3 3567.5 3568.8 5699.9 6442.8 6667.4 6721.2 6839.1 5091.1 5167.4 6622.3 7002.9 7010.9 5670.4 5817.0 5915.4 7069.9 7079.2 5540.4 5595.0 6799.2 6829.5 6829.6 5294.6 5815.5 5913.7 6655.9 6732.6 6411.4 6983.4 6992.8 7026.9 7308.3 4400.2 4433.5 4443.4 4447.9 4459.0 6498.4 6764.8 6766.4 6797.3 6835.0 6422.6 6518.2 6537.8 6538.0 6541.2 5073.8 6327.2 6537.4 6540.6 6558.2 5241.9 5494.6 6314.3 6314.9 6397.6 6240.8 6530.4 6534.0 6539.6 6570.4 4983.9 6283.2 6365.1 6377.9 6432.3 11:13:28 INFO - PID 1654 | 11:13:28 INFO - PID 1654 | [#5] yui.html Cycles:180 Average:20233.68 Median:41366.28 stddev:30121.95 (72.8%) stddev-sans-first:30170.57 11:13:28 INFO - PID 1654 | Values: 653.6 731.0 731.5 737.1 745.9 15648.9 16491.6 16558.8 16560.2 16611.7 14516.3 14522.1 14542.4 14544.9 16875.5 896.2 937.7 944.6 945.1 945.3 972.9 976.0 977.2 978.0 979.7 992.7 1025.2 1030.4 1030.5 1030.7 1016.8 1019.1 1019.9 1020.5 1020.6 767.0 767.0 768.2 769.0 769.0 16252.3 16607.9 16779.0 16946.1 17259.8 14984.1 15033.4 15075.5 15109.9 16083.8 11537.9 11924.6 11940.8 12060.9 12315.5 3036.6 3067.6 3126.9 3133.4 3174.6 104158.4 110555.8 117720.8 117824.0 119625.8 11517.4 11647.5 11661.1 11716.6 11979.4 25487.6 25489.4 25500.6 25513.7 25514.3 7953.6 8003.5 8069.0 8154.6 8350.0 3506.8 4066.7 4164.6 4208.5 4215.1 4152.3 4218.6 4233.3 4244.2 4260.1 828.1 828.8 839.2 839.8 848.4 536.4 553.5 556.5 577.9 580.7 9725.2 9737.0 10198.6 10256.7 10308.3 519.9 524.8 531.4 562.3 584.0 4391.1 4668.2 4695.7 4697.9 4851.6 105683.4 107304.5 108318.5 108605.0 109552.4 78562.0 95581.5 97206.0 97483.0 97841.5 76616.6 77798.0 79282.6 79631.6 82294.8 7953.8 8651.4 9356.1 9370.2 9399.9 23737.8 41312.6 41420.0 41539.6 41572.3 52657.7 52688.0 53675.0 53832.5 54421.0 11196.2 11863.1 11990.0 12224.1 12415.9 12864.5 12875.2 12891.0 13001.8 13108.8 11936.2 11994.5 12057.3 12100.4 12442.1 11814.9 11928.1 11992.7 12052.9 12350.1 11466.3 11779.1 11926.5 12132.2 12394.8 8800.4 8833.6 8915.9 8975.6 9113.0 9028.9 9915.0 9943.6 9952.0 9958.7 11:13:28 INFO - PID 1654 | -------- Summary: end -------- 11:13:28 INFO - PID 1654 | 11:13:28 INFO - TEST-INFO | 1654: exit 0 11:13:28 INFO - TEST-OK | dromaeo_css | took 1121853ms 11:13:28 INFO - TEST-START | kraken 11:13:28 INFO - operating with platform_type : mac_ 11:13:28 INFO - Initialising browser for kraken test... 11:13:28 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpH5G0aH/profile http://localhost:49244/getInfo.html) 11:13:31 INFO - PID 1660 | __metrics Screen width/height:1600/1200 11:13:31 INFO - PID 1660 | colorDepth:24 11:13:31 INFO - PID 1660 | Browser inner width/height: 1024/689 11:13:31 INFO - PID 1660 | __metrics 11:13:31 INFO - PID 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:13:31 INFO - PID 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:32 INFO - TEST-INFO | 1660: exit 0 11:13:32 INFO - Browser initialized. 11:13:32 INFO - Running cycle 1/1 for kraken test... 11:13:32 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpH5G0aH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:44 INFO - PID 1661 | RSS: Main: 232423424 11:13:44 INFO - PID 1661 | 11:13:46 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:47 INFO - PID 1661 | RSS: Main: 286244864 11:13:47 INFO - PID 1661 | 11:13:50 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 11:13:51 INFO - PID 1661 | RSS: Main: 287764480 11:13:51 INFO - PID 1661 | 11:13:54 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 11:13:55 INFO - PID 1661 | RSS: Main: 380993536 11:13:55 INFO - PID 1661 | 11:13:57 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 11:13:58 INFO - PID 1661 | RSS: Main: 283451392 11:13:58 INFO - PID 1661 | 11:14:00 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:01 INFO - PID 1661 | RSS: Main: 285642752 11:14:01 INFO - PID 1661 | 11:14:04 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:04 INFO - PID 1661 | RSS: Main: 328081408 11:14:04 INFO - PID 1661 | 11:14:08 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:08 INFO - PID 1661 | RSS: Main: 340885504 11:14:08 INFO - PID 1661 | 11:14:11 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 11:14:12 INFO - PID 1661 | RSS: Main: 350134272 11:14:12 INFO - PID 1661 | 11:14:14 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:14 INFO - PID 1661 | RSS: Main: 304173056 11:14:14 INFO - PID 1661 | 11:14:16 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:17 INFO - PID 1661 | RSS: Main: 304431104 11:14:17 INFO - PID 1661 | 11:14:19 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:20 INFO - PID 1661 | RSS: Main: 306229248 11:14:20 INFO - PID 1661 | 11:14:23 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:24 INFO - PID 1661 | RSS: Main: 327327744 11:14:24 INFO - PID 1661 | 11:14:27 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:27 INFO - PID 1661 | RSS: Main: 321441792 11:14:27 INFO - PID 1661 | 11:14:29 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 11:14:30 INFO - PID 1661 | RSS: Main: 384471040 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | __start_tp_report 11:14:30 INFO - PID 1661 | _x_x_mozilla_page_load 11:14:30 INFO - PID 1661 | _x_x_mozilla_page_load_details 11:14:30 INFO - PID 1661 | |i|pagename|runs| 11:14:30 INFO - PID 1661 | |0;ai-astar;112;123;123;122;123;122;123;121;123;122 11:14:30 INFO - PID 1661 | |1;audio-beat-detection;156;139;101;154;123;159;154;142;144;117 11:14:30 INFO - PID 1661 | |2;audio-dft;206;210;215;213;210;214;211;218;216;208 11:14:30 INFO - PID 1661 | |3;audio-fft;83;63;65;97;66;65;67;60;80;65 11:14:30 INFO - PID 1661 | |4;audio-oscillator;94;74;94;75;76;101;104;76;86;83 11:14:30 INFO - PID 1661 | |5;imaging-gaussian-blur;92;90;91;90;91;90;90;91;91;90 11:14:30 INFO - PID 1661 | |6;imaging-darkroom;128;141;100;100;100;100;101;99;100;99 11:14:30 INFO - PID 1661 | |7;imaging-desaturate;103;100;100;103;94;104;82;162;162;107 11:14:30 INFO - PID 1661 | |8;json-parse-financial;52;50;51;51;52;52;52;51;52;53 11:14:30 INFO - PID 1661 | |9;json-stringify-tinderbox;59;58;71;77;68;68;62;63;65;62 11:14:30 INFO - PID 1661 | |10;stanford-crypto-aes;91;91;88;91;88;88;92;92;92;90 11:14:30 INFO - PID 1661 | |11;stanford-crypto-ccm;142;168;169;174;149;150;154;151;193;158 11:14:30 INFO - PID 1661 | |12;stanford-crypto-pbkdf2;199;202;199;197;201;202;199;201;207;205 11:14:30 INFO - PID 1661 | |13;stanford-crypto-sha256-iterative;72;75;73;73;75;75;73;74;72;74 11:14:30 INFO - PID 1661 | __end_tp_report 11:14:30 INFO - PID 1661 | __start_cc_report 11:14:30 INFO - PID 1661 | _x_x_mozilla_cycle_collect,2158 11:14:30 INFO - PID 1661 | __end_cc_report 11:14:30 INFO - PID 1661 | __startTimestamp1491070470056__endTimestamp 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | ------- Summary: start ------- 11:14:30 INFO - PID 1661 | Number of tests: 14 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#0] ai-astar Cycles:10 Average:121.40 Median:123.00 stddev:3.37 (2.7%) stddev-sans-first:0.73 11:14:30 INFO - PID 1661 | Values: 112.0 123.0 123.0 122.0 123.0 122.0 123.0 121.0 123.0 122.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:149.00 stddev:19.31 (13.0%) stddev-sans-first:19.47 11:14:30 INFO - PID 1661 | Values: 156.0 139.0 101.0 154.0 123.0 159.0 154.0 142.0 144.0 117.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#2] audio-dft Cycles:10 Average:212.10 Median:213.50 stddev:3.75 (1.8%) stddev-sans-first:3.27 11:14:30 INFO - PID 1661 | Values: 206.0 210.0 215.0 213.0 210.0 214.0 211.0 218.0 216.0 208.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#3] audio-fft Cycles:10 Average:71.10 Median:66.50 stddev:11.71 (17.6%) stddev-sans-first:11.61 11:14:30 INFO - PID 1661 | Values: 83.0 63.0 65.0 97.0 66.0 65.0 67.0 60.0 80.0 65.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:79.50 stddev:11.30 (14.2%) stddev-sans-first:11.64 11:14:30 INFO - PID 1661 | Values: 94.0 74.0 94.0 75.0 76.0 101.0 104.0 76.0 86.0 83.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:91.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 11:14:30 INFO - PID 1661 | Values: 92.0 90.0 91.0 90.0 91.0 90.0 90.0 91.0 91.0 90.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:114.50 stddev:14.93 (13.0%) stddev-sans-first:13.72 11:14:30 INFO - PID 1661 | Values: 128.0 141.0 100.0 100.0 100.0 100.0 101.0 99.0 100.0 99.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:134.50 stddev:27.41 (20.4%) stddev-sans-first:28.89 11:14:30 INFO - PID 1661 | Values: 103.0 100.0 100.0 103.0 94.0 104.0 82.0 162.0 162.0 107.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.84 (1.6%) stddev-sans-first:0.88 11:14:30 INFO - PID 1661 | Values: 52.0 50.0 51.0 51.0 52.0 52.0 52.0 51.0 52.0 53.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:66.50 stddev:5.81 (8.7%) stddev-sans-first:5.70 11:14:30 INFO - PID 1661 | Values: 59.0 58.0 71.0 77.0 68.0 68.0 62.0 63.0 65.0 62.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:91.00 stddev:1.70 (1.9%) stddev-sans-first:1.79 11:14:30 INFO - PID 1661 | Values: 91.0 91.0 88.0 91.0 88.0 88.0 92.0 92.0 92.0 90.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:163.00 stddev:15.24 (9.3%) stddev-sans-first:14.56 11:14:30 INFO - PID 1661 | Values: 142.0 168.0 169.0 174.0 149.0 150.0 154.0 151.0 193.0 158.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.20 Median:201.50 stddev:3.01 (1.5%) stddev-sans-first:3.09 11:14:30 INFO - PID 1661 | Values: 199.0 202.0 199.0 197.0 201.0 202.0 199.0 201.0 207.0 205.0 11:14:30 INFO - PID 1661 | 11:14:30 INFO - PID 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.17 (1.6%) stddev-sans-first:1.09 11:14:30 INFO - PID 1661 | Values: 72.0 75.0 73.0 73.0 75.0 75.0 73.0 74.0 72.0 74.0 11:14:30 INFO - PID 1661 | -------- Summary: end -------- 11:14:30 INFO - PID 1661 | 11:14:30 INFO - TEST-INFO | 1661: exit 0 11:14:30 INFO - TEST-OK | kraken | took 62114ms 11:14:30 INFO - SUITE-END | took 1183s 11:14:31 INFO - Completed test suite (00:19:44) 11:14:31 INFO - javascript benchmark 11:14:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7622.413975292164, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3554.0937061049435, 3578.069701877511, 3582.7312951528643, 3588.049166970753, 3633.981830090851, 5123.564497017749, 6131.325554189036, 6266.811995640127, 6310.274318453374, 6317.115603815464, 6156.076588511725, 6200.441960223579, 6253.499720022399, 6256.718447669854, 6264.342244064376, 4610.792514336863, 5261.000409922121, 5453.727313634322, 5474.069408200616, 5487.149491828753, 5538.806141785039, 5562.833115006556, 5576.275084239043, 5578.470045345706, 5610.66336019838, 5305.283786688786, 5393.649412788156, 5402.810901618424, 5408.107662235727, 5498.642588231792, 5494.423085575997, 5501.697406642633, 5543.833684989457, 5546.833594992157, 5560.833175004756, 5411.594130440233, 5427.158790387457, 5431.728413579305, 5438.646487978269, 5439.700816455093, 6265.216847894013, 6268.1851359323455, 6272.6236425814595, 6275.905861412082, 6291.402316779944, 6218.968905155445, 6278.4663303619245, 6306.905396419057, 6307.810765676991, 6587.374199451045, 6732.29310922351, 6756.628385438799, 6781.830454238634, 6783.59298442095, 6800.217974932847, 6324.462420694293, 6345.587536810092, 6375.10748495211, 6408.070829729663, 6416.615003099829, 6605.801825945133, 6677.332266773284, 6689.03009063683, 6944.826379340456, 6958.756443524554, 6295.520552670119, 6417.422431981144, 6510.446612037935, 6519.967400162969, 6551.770688025897, 6013.1581578579035, 6758.5269031167345, 6823.112995310677, 6825.180978282638, 6825.897611535831, 6330.525210609223, 6684.632345220963, 6690.598564086073, 6711.429528490133, 6711.563748356341, 6418.069379939882, 6419.903701444482, 6430.196225471816, 6448.645324507103, 6549.312322206195, 5349.144136938071, 5366.248725178478, 5387.4073851876265, 5387.515123638891, 5393.5954803389905, 4761.761911904391, 4774.9522504775205, 4776.498467660915, 4782.736949467743, 4785.353977213102, 6248.156498872685, 6386.07401926718, 6392.4246817786625, 6394.488440924715, 6419.422251997343, 6533.24867640218, 6545.312742162099, 6559.868802623921, 6570.704318305688, 6572.934270657328, 6315.210598675166, 6319.0, 6323.27282362525, 6326.051092336094, 6333.081703153017, 5956.76172953077, 5977.701114944235, 6002.339742628395, 6021.5182785377065, 6042.758289668364, 6941.132358455193, 6998.825029374307, 7005.05431766705, 7008.5094043416475, 7016.298370162943, 6469.708863101266, 6522.28254891971, 6802.523823332517, 6831.0, 6834.350736680008, 6745.966270168814, 6907.13660792401, 6983.162020557363, 6992.265812089658, 7007.544509606859, 6670.76652317186, 6675.7997260082275, 6679.8664026718225, 6690.163729533809, 6690.230623478362, 6422.678866056585, 6762.459003279628, 6765.729370825112, 6772.424343930821, 6795.3204679531655, 6357.0, 6357.713902874474, 6442.774502892376, 6469.838254043687, 6502.739890404331, 6519.0, 6533.085368048382, 6552.705128269144, 6557.344265573404, 6561.278259391559, 4906.8773280668265, 5417.864553386197, 6308.936910630835, 6404.7438102477245, 6435.131257280207, 5529.253550770594, 6324.747010119544, 6366.9681651591445, 6372.107904893226, 6544.476441884733, 5664.291963504562, 6346.143270658402, 6351.364863513611, 6381.585196962183, 6384.872302554016], "value": 6089.001461516551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.2469880721665, 796.2873228460527, 815.2214635023553, 1129.9999999999995, 1152.8847115288477, 28612.141635750933, 37637.0, 38149.23701525968, 38194.42708359377, 38238.808805956, 40491.392629110516, 40840.59159408405, 40859.0, 40881.18237635253, 40884.182316353654, 6145.231846019247, 8519.57402129894, 8717.825643487127, 8722.38943273971, 8752.431091979033, 6168.691565421734, 7296.197418283985, 8488.278496327819, 8620.224179823814, 8625.266852317529, 8642.783930401727, 8690.478571285743, 8699.52152631605, 8714.172153645426, 8735.956320218422, 8636.611352489123, 8675.305975522006, 8698.173673501007, 8698.478091314479, 8709.651613935435, 8464.1112683168, 8530.274926631244, 8533.591957327033, 8533.74398768038, 8538.27424668904, 37894.81052594747, 38125.428118578246, 38176.854694359216, 38214.23571528582, 38343.42484862729, 2951.940961180764, 3018.4566777979953, 3022.5163973764093, 3034.286942568495, 3066.739327157194, 26460.60309095365, 26697.866510667518, 26733.19800405991, 26867.0, 27149.321266968287, 2785.220138361262, 2822.393185465135, 2830.6603207615217, 2874.3101655602713, 2883.4665586866495, 315082.0, 315525.0, 315737.8475260088, 316347.4182629072, 317405.9999999977, 48059.519404805505, 48100.0, 48125.75937120292, 48292.758536207795, 48352.164783521366, 50415.0, 50450.4864854055, 50453.0, 50470.74764626153, 50619.24071138936, 14049.578512644433, 14438.783418248735, 14473.203973781332, 14479.92760036193, 14491.710165796625, 10033.899661003297, 10200.97990200974, 11692.766144677229, 11710.0, 11798.292102473879, 11763.294202347886, 13242.735145297233, 13456.461741530426, 13540.729185416236, 13582.45670173182, 5757.366689664133, 5865.149553314745, 5929.584929055011, 5931.110333450017, 5954.434328738763, 941.6346297868118, 971.7424882406168, 981.1954197557934, 984.2224642532319, 1026.825439675242, 24004.39989000254, 24067.0, 24069.879650601633, 24153.275401737978, 24157.275281741575, 1077.902988731018, 1084.1760262200785, 1132.4620805117504, 1141.7145713571608, 1146.529922731676, 12118.515259389525, 12286.692832679075, 12311.630651080482, 12332.260064396165, 12346.75306493883, 484416.0, 487825.0, 488479.0, 490035.0, 490443.0, 55171.0, 55549.0, 55595.166072508946, 55696.0, 55847.72076139593, 1442.0986883198002, 1481.2445652716976, 1526.7862499250336, 1532.7470967290494, 1543.2129613896768, 19276.903615482395, 20594.485137871674, 23643.763562364846, 23691.52616947686, 23744.050237990978, 38539.6146038536, 38573.0, 38628.80685596554, 38652.0, 38709.99999999887, 400410.0, 400756.0, 401738.0, 401750.0, 402380.0, 27443.588346175224, 33502.99491015273, 33768.49347259744, 33856.83071584626, 34056.0, 42665.0, 44026.899327515785, 44117.77941110274, 44179.337309939736, 44231.77884110559, 25344.619830702184, 27931.882724690786, 30022.3995520084, 30103.698963010967, 30272.243193920327, 29097.0, 29493.26266843346, 30147.246318842204, 30262.69737302599, 30385.24036899095, 35590.64409355873, 35718.92843214708, 36174.63825361818, 36190.45714314235, 36519.08702282358, 28940.42119157647, 29797.255068623457, 30375.0, 30387.074520468297, 30527.931522396608, 23640.645390318816, 23712.0, 23712.932918019076, 23950.0, 24374.756252437957], "value": 17589.734823539875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.92108283531866, 424.5070436185832, 434.94345735054446, 436.93664418659296, 454.48189064466516, 11998.640040798779, 22363.776362236393, 22483.887580562096, 23363.1822886199, 23418.0, 20057.29799457019, 22052.88973555134, 22722.431939201528, 22831.657525137136, 23015.964281607325, 4592.839250626229, 5246.37043554773, 5537.750801213935, 6410.2628197757385, 6442.516811239152, 3777.2067865748227, 3956.940645890314, 3957.9604203958024, 6233.968830155843, 6417.775377861776, 6105.481034112106, 6364.968175159118, 6377.681115944208, 6381.457576106037, 6385.457236134934, 6072.392760723937, 6197.566170368076, 6269.2476902771505, 6280.340564240781, 6355.142055822451, 5570.303712035996, 5573.136163894603, 5581.246531718207, 5581.609287349887, 5588.776448942038, 25328.873355633288, 28168.0, 29204.8539757302, 29388.559171612444, 29488.70511294881, 1990.4028791362678, 2018.9192432302837, 2028.5334373094272, 2058.5574101568236, 2075.408508575049, 15561.37754489819, 16113.27490262941, 16719.66560668792, 17109.31562737489, 17627.206775695126, 1847.9168437420215, 1865.9533511662182, 1867.1411150870615, 1899.8736733211947, 1905.8380037696813, 138156.30921845426, 151392.0, 161494.0, 161500.0, 166436.0, 9982.201423886072, 10056.899431005597, 12538.0, 12598.307093109966, 12803.871961280269, 16535.25591348392, 16561.337546498246, 16593.087380193963, 16600.83399166017, 16605.6678866422, 8620.137986201455, 8892.466452012899, 8926.642934282685, 9074.500902450296, 9077.77305567366, 8225.670973161126, 8476.321894248445, 8491.405601607952, 8613.181747733955, 8636.395452318277, 6494.6752662367635, 7777.183395743478, 7907.327877130393, 7928.524288542706, 7957.403194760416, 2061.3506745375157, 2126.2983215538834, 2154.978450215509, 2182.8144607708523, 2311.202635090891, 849.3926842307656, 910.349100393222, 918.8284936705753, 938.1462868789368, 946.7301818981557, 18244.0, 20664.0, 20680.069396877177, 20725.68911466329, 20728.58542829165, 931.6552875435997, 945.6737425588299, 960.2845879819439, 976.7460460280379, 985.8225519406433, 9052.27581793455, 10091.949540252399, 10545.261831671864, 10571.596232457674, 10743.623973161059, 714422.0, 715279.0, 722536.0, 723612.7290453237, 747720.0, 157464.0, 157865.2106739482, 159748.0, 160234.0, 161500.19249903676, 1139.2651739627893, 1150.1546363422879, 1180.9704757380962, 1181.5923506390282, 1223.902087832989, 20181.39455816328, 21373.114629525437, 21462.46343841354, 21467.745886681674, 21570.892145539172, 59692.70153649204, 60367.0, 60369.0, 60444.39555604388, 60816.39183608107, 82400.0, 83720.0, 84969.0, 86197.0, 86683.0, 7834.0, 8258.380621453534, 8360.916390836257, 8406.95796521038, 8658.567071646266, 12547.3098979557, 12577.622671319876, 12621.432035558239, 12863.807042894177, 12864.0, 10907.345559266469, 10970.451477426257, 11166.832497512381, 11279.830802537805, 11400.657980260605, 9974.301798874008, 10116.595336186765, 10186.592536298465, 10367.688969330931, 10380.688579342632, 11186.049185819296, 11627.6511704649, 11817.936385725327, 12044.156909016636, 12072.818907716215, 6687.933120668926, 6887.242403335529, 8235.723462863265, 8358.87461688063, 8618.569071546523, 9344.972053074292, 11188.832167517656, 11347.375894325562, 11484.540618375171, 11567.768644626893], "value": 10264.250440080956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.8848347890428, 1409.6969151632397, 1424.1526291856349, 1442.632128807154, 1443.1629654800217, 10249.436281004542, 10743.15306443793, 10746.946265268663, 10748.516316765745, 10761.569537218511, 10374.325668831521, 10545.42000189991, 10738.08726258269, 10744.301620394668, 10753.30103543269, 2382.95234095318, 2453.766892145243, 2456.385903524119, 2457.9016839326496, 2458.373114855718, 2286.0969916882823, 2443.657887895696, 2465.963010554843, 2467.037855236459, 2472.1223965492263, 2056.064490656755, 2140.283005193262, 2143.0463443767453, 2371.0, 2459.6187590923437, 2417.7944874685672, 2442.120836498859, 2446.22943772711, 2448.204333591581, 2450.7426720194303, 2405.1461731085387, 2416.32342943976, 2427.963580546293, 2457.5207834472285, 2460.2250291158407, 10686.625968091079, 10766.569337226501, 10772.784544309148, 10802.783944321069, 10803.621873234399, 6096.939030609726, 6327.746890124389, 6339.0808332791485, 6342.016987366919, 6348.428641422248, 3347.96652033479, 3758.32350176968, 3785.205106927521, 3985.0236692010644, 4011.5587285398583, 1152.1704372851534, 1155.3587758793867, 1187.7921363761393, 1208.3354155214597, 1216.0697066743949, 14752.041117327339, 14897.180655063967, 15120.924395378062, 15143.394264229528, 15222.010569312959, 5322.0, 5607.579431542651, 5626.465485778845, 5629.605927585029, 5696.405006598159, 12638.747225055447, 12641.557545486048, 12646.683832904251, 12652.620421387373, 12668.809967850306, 6349.6507692077375, 6353.30113687494, 6353.30113687494, 6358.650274234869, 6364.0, 5622.57830662702, 5697.4302569742695, 5802.0, 5831.912521312183, 5855.502282305966, 4237.237297286518, 4368.934465983013, 4382.255016647177, 4431.113777244564, 4435.0, 1229.3914512316283, 1353.3301015996947, 1356.0643156222175, 1393.5749596373203, 1415.186267895964, 735.88961655751, 750.9549427034395, 774.6436639145943, 780.8165081205912, 808.3694718119876, 6065.332813390523, 6734.730610775514, 6955.547889387173, 7013.403860671798, 7014.508984371045, 838.9580520973927, 850.4089657687848, 899.0829354058824, 908.4413085952092, 933.5332333833084, 4006.6794656427414, 4035.1526179502634, 4099.344104943195, 4113.876583702494, 4252.298370768788, 13205.933970330087, 13768.862311376959, 13785.793213101811, 13795.586132415843, 13804.516841910485, 13662.795058074136, 13672.0, 13696.863031369758, 13698.726025479435, 13705.931470342784, 9715.0, 10135.594576217016, 10143.543540540693, 10149.746256343502, 10167.847482287772, 5172.5603323717905, 5783.306003279633, 5965.582409231486, 6408.263049749152, 6782.599166122901, 12064.215825971283, 12135.878641213474, 12252.326122063372, 12356.073294502768, 12449.564265250672, 12311.938440307742, 12321.0, 12459.875401246234, 12548.874511255135, 12570.497180112692, 8901.465912045298, 9181.219596334386, 9205.723828285161, 9212.585433655635, 9253.58358873839, 9909.207263419054, 9950.35322704022, 10094.141997929964, 10096.798064038825, 10133.442660653734, 7097.751578694721, 8380.24577788002, 8444.408891377545, 8484.321254299764, 8687.956560217159, 8352.6241319142, 8383.916160838313, 8431.40980131385, 8508.74473765788, 8532.872006920024, 7600.125985511737, 7644.694212231449, 7680.5391676499585, 7734.419918506247, 7778.261065198797, 5871.089981052944, 5908.202392676933, 5909.763609455574, 5917.201177841109, 5988.910166347421, 5859.150423188699, 5917.1715959766525, 5931.258592675916, 5949.672767997802, 6008.459238668541], "value": 5172.415826798571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.4678928847738, 388.97893030794165, 393.75980651802394, 406.07009947220865, 406.932856078747, 5505.054795684309, 5513.173024046395, 6064.757409703612, 6144.723487443064, 6183.474404675602, 4990.5259000395, 5454.127339625651, 5661.3206415230125, 5885.764569417218, 5994.3215899548195, 4050.9392359114636, 4171.955741686582, 4188.97370144315, 4458.66560007999, 4458.97770511147, 3664.3404187246283, 3771.0949372150762, 4480.790186649602, 4493.752843593601, 4497.820087196525, 3661.2677464507074, 4216.409702641633, 4333.1766964276685, 4405.88985275369, 4435.68950173488, 4399.758013309267, 4406.030673251879, 4425.977870110661, 4455.1535208310315, 4456.353828694837, 3811.8284677189595, 3818.083659921627, 3827.1771569112498, 3838.157684311518, 3840.711946604016, 5125.615578831603, 5741.799037033684, 5832.591718579701, 5926.851828704273, 5942.97028514859, 4614.077184563101, 5145.562627176657, 5320.467953204688, 5329.493698098674, 5354.571634269249, 5296.629235953485, 6406.487481001509, 6494.350564943515, 6494.90257646131, 6517.087607734921, 3655.5613326400735, 4158.625723684883, 4302.784860756981, 4359.847405340798, 4372.89067773305, 6546.545045607897, 6740.662966851638, 6743.022261772016, 6812.284710105467, 6900.965495172542, 3681.815909204529, 4288.89277768052, 4395.033092719596, 4417.160739459492, 4431.556844315543, 3725.441183822394, 4495.685302028892, 4495.797689103998, 4516.503184649686, 4521.412216411845, 4733.408323959505, 4974.825881094144, 5126.79492820283, 5186.714730689849, 5302.363716353985, 5577.470140336662, 6327.4373878579245, 6459.289478157399, 6466.960528551574, 6469.676516174172, 1282.224254326138, 1497.6929729405663, 1497.9470758108594, 1530.778037184602, 1543.1589783567983, 951.8048799995984, 957.8314456363225, 980.3823591137681, 1007.5717819926648, 1012.5595366015659, 4705.788239529229, 4891.730954797449, 5200.141976573898, 6188.452886778306, 6218.0, 5826.970865145647, 5858.882822343615, 6265.404786545362, 6725.764598239038, 6742.730290788411, 5447.782088716486, 5562.694051827189, 6291.5281353898645, 6327.145835312174, 6374.58565193261, 3382.1251935854325, 3541.256336169382, 3564.2891412122326, 3567.501649307297, 3568.8044505091084, 5699.943000570024, 6442.840288748071, 6667.366600172976, 6721.1598550181225, 6839.110915581042, 5091.137963245092, 5167.379914410295, 6622.304658010839, 7002.859942801116, 7010.92989070113, 5670.432956704297, 5817.040188368872, 5915.438033386908, 7069.8939515907305, 7079.159418551214, 5540.418256083214, 5595.0, 6799.218089919525, 6829.453643708392, 6829.6243706596615, 5294.564500329891, 5815.476607105381, 5913.6747478887355, 6655.900161497679, 6732.562383445061, 6411.4229719325485, 6983.406410455168, 6992.79021629352, 7026.894596581157, 7308.342249197598, 4400.163968845909, 4433.534478879671, 4443.400140980926, 4447.933281000723, 4459.0, 6498.415142637185, 6764.797056088325, 6766.391024807791, 6797.320267973361, 6834.965825170842, 6422.550421470452, 6518.185226846645, 6537.771178008747, 6538.0, 6541.215054193337, 5073.822416215415, 6327.2283760547125, 6537.411632952867, 6540.607563546202, 6558.213014438298, 5241.868953276198, 5494.587905907153, 6314.273858506147, 6314.905276420949, 6397.6481293529305, 6240.843978900564, 6530.444912182327, 6533.967330163318, 6539.607623542603, 6570.441512471493, 4983.8504844854715, 6283.183186185949, 6365.077063825812, 6377.8724425512155, 6432.2602900667025], "value": 4637.273256700825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.5686446945017, 731.010168411198, 731.4514114414189, 737.0946352027257, 745.8955746195534, 15648.921755391235, 16491.58771030725, 16558.834411655895, 16560.171991400442, 16611.66776664466, 14516.274186290697, 14522.128672279645, 14542.418303267883, 14544.927275363634, 16875.493735187963, 896.2068569316153, 937.7421209167466, 944.6032666280145, 945.1446440970898, 945.3288165402538, 972.9270304727174, 975.9951200243988, 977.1791694976218, 977.9926675524222, 979.7158823941048, 992.6773798515475, 1025.2361990317224, 1030.361176070837, 1030.469308306223, 1030.6959446963126, 1016.7508960304773, 1019.133736324126, 1019.8521214423866, 1020.4948550467492, 1020.6019652335596, 766.9616519174019, 767.0373681030327, 768.2202564397086, 768.9577073260969, 769.0425420351698, 16252.268647910872, 16607.91696041524, 16779.0, 16946.06796626185, 17259.827401725946, 14984.100953942689, 15033.398664053424, 15075.54773356801, 15109.924450377788, 16083.839161608352, 11537.88462115385, 11924.582639607659, 11940.761184776256, 12060.939695301555, 12315.5073797048, 3036.5748795168693, 3067.6318841739135, 3126.89055883043, 3133.4359815233247, 3174.6349169845535, 104158.4376234357, 110555.78888422187, 117720.8227917727, 117824.0, 119625.80374196234, 11517.366544840113, 11647.534098635959, 11661.067114630809, 11716.589919352782, 11979.401029948467, 25487.617685734727, 25489.362765931, 25500.617490737655, 25513.662677344895, 25514.300426438433, 7953.562554059582, 8003.4797738146835, 8069.0, 8154.633041513146, 8350.039745429232, 3506.8421921013614, 4066.674666026711, 4164.562720914321, 4208.516020657664, 4215.114825886537, 4152.294110001307, 4218.578142185818, 4233.343831706091, 4244.193603215379, 4260.0840819223395, 828.0849661124491, 828.8135169586915, 839.2404873589411, 839.8320335932716, 848.4315508609246, 536.4126281721509, 553.532265235875, 556.5325126893429, 577.8988676981595, 580.6864293281665, 9725.173360264314, 9737.0, 10198.592056317813, 10256.692299231036, 10308.278420510493, 519.9220116982407, 524.79270688078, 531.4446403508343, 562.3420597900466, 583.988320233593, 4391.121775644884, 4668.229742092584, 4695.652173913043, 4697.929531056969, 4851.636127290467, 105683.41474877883, 107304.46347768212, 108318.45840770745, 108605.0, 109552.35671464934, 78562.03594910173, 95581.52209238909, 97206.0279397197, 97483.0, 97841.51079244558, 76616.61691691617, 77798.0, 79282.6035869817, 79631.60184199158, 82294.76557851637, 7953.761387158394, 8651.351148663749, 9356.111169438893, 9370.203532699525, 9399.906000940176, 23737.762622373557, 41312.586874132074, 41419.96450088772, 41539.58460415357, 41572.25849673544, 52657.736711316196, 52688.0, 53675.0, 53832.46167538274, 54421.0, 11196.160287978597, 11863.110266729856, 11990.0, 12224.144309898222, 12415.93792031034, 12864.549740759028, 12875.227486350848, 12890.985845542587, 13001.804972925225, 13108.803367949298, 11936.224145430519, 11994.520219191134, 12057.336846473529, 12100.432797181307, 12442.129050966345, 11814.881851181379, 11928.105392095455, 11992.695412679413, 12052.879471205175, 12350.135490515937, 11466.31202127875, 11779.05767538612, 11926.4688356571, 12132.150749447806, 12394.75210495803, 8800.427972181787, 8833.64665413402, 8915.910840891507, 8975.596098175467, 9112.95443522778, 9028.909710902806, 9915.0, 9943.552540135855, 9951.950240248752, 9958.651447199314], "value": 7437.620072475942, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 123.0, 122.0, 123.0, 122.0, 123.0, 121.0, 123.0, 122.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 139.0, 101.0, 154.0, 123.0, 159.0, 154.0, 142.0, 144.0, 117.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 210.0, 215.0, 213.0, 210.0, 214.0, 211.0, 218.0, 216.0, 208.0], "value": 212.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 63.0, 65.0, 97.0, 66.0, 65.0, 67.0, 60.0, 80.0, 65.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 74.0, 94.0, 75.0, 76.0, 101.0, 104.0, 76.0, 86.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 90.0, 91.0, 90.0, 90.0, 91.0, 91.0, 90.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 141.0, 100.0, 100.0, 100.0, 100.0, 101.0, 99.0, 100.0, 99.0], "value": 106.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 100.0, 100.0, 103.0, 94.0, 104.0, 82.0, 162.0, 162.0, 107.0], "value": 111.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 51.0, 52.0, 52.0, 52.0, 51.0, 52.0, 53.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 71.0, 77.0, 68.0, 68.0, 62.0, 63.0, 65.0, 62.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 88.0, 91.0, 88.0, 88.0, 92.0, 92.0, 92.0, 90.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 168.0, 169.0, 174.0, 149.0, 150.0, 154.0, 151.0, 193.0, 158.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 202.0, 199.0, 197.0, 201.0, 202.0, 199.0, 201.0, 207.0, 205.0], "value": 201.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 73.0, 73.0, 75.0, 75.0, 73.0, 74.0, 72.0, 74.0], "value": 73.6, "unit": "score"}]}]} 11:14:31 INFO - Return code: 0 11:14:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:14:31 ERROR - # TBPL SUCCESS # 11:14:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:31 INFO - 2017-04-01 11:14:31.366 screenresolution[1665:13138] starting screenresolution argv=screenresolution get 11:14:31 INFO - 2017-04-01 11:14:31.369 screenresolution[1665:13138] Display 0: 1600x1200x32@60 11:14:31 INFO - 2017-04-01 11:14:31.375 screenresolution[1666:13142] starting screenresolution argv=screenresolution list 11:14:31 INFO - Available Modes on Display 0 11:14:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:31 INFO - Intel Iris: 11:14:31 INFO - Chipset Model: Intel Iris 11:14:31 INFO - Type: GPU 11:14:31 INFO - Bus: Built-In 11:14:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:31 INFO - Vendor: Intel (0x8086) 11:14:31 INFO - Device ID: 0x0a2e 11:14:31 INFO - Revision ID: 0x0009 11:14:31 INFO - Displays: 11:14:31 INFO - Display: 11:14:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:31 INFO - Display Serial Number: 1600x1200 60 11:14:31 INFO - Main Display: Yes 11:14:31 INFO - Mirror: Off 11:14:31 INFO - Online: Yes 11:14:31 INFO - Rotation: Supported 11:14:31 INFO - Return code: 0 11:14:31 INFO - Running post-action listener: _resource_record_post_action 11:14:31 INFO - [mozharness: 2017-04-01 18:14:31.615916Z] Finished run-tests step (success) 11:14:31 INFO - Running post-run listener: _resource_record_post_run 11:14:31 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 34348032; Write bytes: 518791168; Read time: 321; Write time: 1668 11:14:31 INFO - TinderboxPrint: CPU usage
53.4% 11:14:31 INFO - TinderboxPrint: I/O read bytes / time
34,348,032 / 321 11:14:31 INFO - TinderboxPrint: I/O write bytes / time
518,791,168 / 1,668 11:14:31 INFO - TinderboxPrint: CPU idle
2,245.6 (46.6%) 11:14:31 INFO - TinderboxPrint: CPU system
967.0 (20.1%) 11:14:31 INFO - TinderboxPrint: CPU user
1,609.1 (33.4%) 11:14:31 INFO - TinderboxPrint: Swap in / out
241,414,144 / 0 11:14:31 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200593920; Write bytes: 196380672; Read time: 15824; Write time: 474 11:14:31 INFO - run-tests - Wall time: 1185s; CPU: 53.0%; Read bytes: 33405952; Write bytes: 302602240; Read time: 306; Write time: 1144 11:14:32 INFO - Running post-run listener: _upload_blobber_files 11:14:32 INFO - Blob upload gear active. 11:14:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:14:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:33 INFO - (blobuploader) - INFO - Done attempting. 11:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:35 INFO - (blobuploader) - INFO - Done attempting. 11:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:14:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:38 INFO - (blobuploader) - INFO - Done attempting. 11:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:40 INFO - (blobuploader) - INFO - Done attempting. 11:14:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:40 INFO - Return code: 0 11:14:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d22b8f7b985cf1215d6019c3dbc15dd11deb6cc5dd0fac2374e1f3efeb5fe9eef22c70ba16796a9fe820f8ac818db5f4e7e12c00aac755aa4afce7ea7a4d7aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622b82a27e78161bd9648fa47436ca6624593e986fa0d20537da0202e23b4a07b8b0c423ee735fc37a2b37752d4e525e6d0f86409101df63e970576a14462969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f9a2f10ab5244995d81bb808b522f3e1bb3c0ddaca15b70e59bc871145b85e0ad51b46b571de38f3cd2e764ef5d72e432f7da3497fbd672243c7b83dbf9339", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb695431c87a95e04131d84da6a26f490c69653358c4566080018dc5e75fea9c8ac324915947509156b123b7c3fa48cb521acd03b8ea42c2f2ef3e307a014698"} 11:14:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:40 INFO - Contents: 11:14:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d22b8f7b985cf1215d6019c3dbc15dd11deb6cc5dd0fac2374e1f3efeb5fe9eef22c70ba16796a9fe820f8ac818db5f4e7e12c00aac755aa4afce7ea7a4d7aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622b82a27e78161bd9648fa47436ca6624593e986fa0d20537da0202e23b4a07b8b0c423ee735fc37a2b37752d4e525e6d0f86409101df63e970576a14462969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f9a2f10ab5244995d81bb808b522f3e1bb3c0ddaca15b70e59bc871145b85e0ad51b46b571de38f3cd2e764ef5d72e432f7da3497fbd672243c7b83dbf9339", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb695431c87a95e04131d84da6a26f490c69653358c4566080018dc5e75fea9c8ac324915947509156b123b7c3fa48cb521acd03b8ea42c2f2ef3e307a014698"} 11:14:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:40 INFO - Copying logs to upload dir... 11:14:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.535327 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-01 11:14:40.533244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:40.536449) ========= 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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d22b8f7b985cf1215d6019c3dbc15dd11deb6cc5dd0fac2374e1f3efeb5fe9eef22c70ba16796a9fe820f8ac818db5f4e7e12c00aac755aa4afce7ea7a4d7aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622b82a27e78161bd9648fa47436ca6624593e986fa0d20537da0202e23b4a07b8b0c423ee735fc37a2b37752d4e525e6d0f86409101df63e970576a14462969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f9a2f10ab5244995d81bb808b522f3e1bb3c0ddaca15b70e59bc871145b85e0ad51b46b571de38f3cd2e764ef5d72e432f7da3497fbd672243c7b83dbf9339", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb695431c87a95e04131d84da6a26f490c69653358c4566080018dc5e75fea9c8ac324915947509156b123b7c3fa48cb521acd03b8ea42c2f2ef3e307a014698"} build_url:https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010905 build_url: 'https://queue.taskcluster.net/v1/task/ELIn0rMMQ0uzyzBNOBNtPA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d22b8f7b985cf1215d6019c3dbc15dd11deb6cc5dd0fac2374e1f3efeb5fe9eef22c70ba16796a9fe820f8ac818db5f4e7e12c00aac755aa4afce7ea7a4d7aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622b82a27e78161bd9648fa47436ca6624593e986fa0d20537da0202e23b4a07b8b0c423ee735fc37a2b37752d4e525e6d0f86409101df63e970576a14462969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f9a2f10ab5244995d81bb808b522f3e1bb3c0ddaca15b70e59bc871145b85e0ad51b46b571de38f3cd2e764ef5d72e432f7da3497fbd672243c7b83dbf9339", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb695431c87a95e04131d84da6a26f490c69653358c4566080018dc5e75fea9c8ac324915947509156b123b7c3fa48cb521acd03b8ea42c2f2ef3e307a014698"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:40.575880) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:40.576276) ========= 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.HX2fsCm9Hs/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.cZMXL8SRkp/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005307 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 11:14:40.626217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 11:14:40.626580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 11:14:40.626969) ========= ========= Total master_lag: 0.20 =========