builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0124 starttime: 1489584901.09 results: success (0) buildid: 20170315050136 builduid: 26314fa4665e4c55b5082917c34fbaa2 revision: 0cc9dced786cf2a3baeff707b636b4ad02637df0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.093623) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.094347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.094685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.122686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.123081) ========= 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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-03-15 06:35:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.0M=0.001s 2017-03-15 06:35:01 (13.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.276849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.277201) ========= 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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.028607 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:01.327429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 06:35:01.327777) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0cc9dced786cf2a3baeff707b636b4ad02637df0 --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 0cc9dced786cf2a3baeff707b636b4ad02637df0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tPLvzI3VAp/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.CLOihtTB9Z/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-03-15 06:35:01,425 truncating revision to first 12 chars 2017-03-15 06:35:01,426 Setting DEBUG logging. 2017-03-15 06:35:01,426 attempt 1/10 2017-03-15 06:35:01,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0cc9dced786c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 06:35:02,933 unpacking tar archive at: mozilla-central-0cc9dced786c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.772939 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 06:35:03.170303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:03.170605) ========= script_repo_revision: 0cc9dced786cf2a3baeff707b636b4ad02637df0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:03.170995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:03.171276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 06:35:03.191391) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-15 06:35:03.191745) ========= /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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:35:03 INFO - MultiFileLogger online at 20170315 06:35:03 in /builds/slave/test 06:35:03 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 06:35:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:03 INFO - {'append_to_log': False, 06:35:03 INFO - 'base_work_dir': '/builds/slave/test', 06:35:03 INFO - 'blob_upload_branch': 'Firefox', 06:35:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:03 INFO - 'branch': 'Firefox', 06:35:03 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:03 INFO - 'config_files': ('talos/mac_config.py',), 06:35:03 INFO - 'default_actions': ('clobber', 06:35:03 INFO - 'read-buildbot-config', 06:35:03 INFO - 'download-and-extract', 06:35:03 INFO - 'populate-webroot', 06:35:03 INFO - 'create-virtualenv', 06:35:03 INFO - 'install', 06:35:03 INFO - 'run-tests'), 06:35:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:03 INFO - 'download_minidump_stackwalk': True, 06:35:03 INFO - 'download_symbols': 'ondemand', 06:35:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:03 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:03 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:03 INFO - 'gecko_profile': False, 06:35:03 INFO - 'gecko_profile_interval': 0, 06:35:03 INFO - 'installer_path': 'installer.exe', 06:35:03 INFO - 'log_level': 'info', 06:35:03 INFO - 'log_name': 'talos', 06:35:03 INFO - 'log_to_console': True, 06:35:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:35:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:35:03 INFO - 'opt_config_files': (), 06:35:03 INFO - 'pip_index': False, 06:35:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:35:03 INFO - 'cmd': ('bash', 06:35:03 INFO - '-c', 06:35:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:35:03 INFO - 'enabled': True, 06:35:03 INFO - 'halt_on_failure': False, 06:35:03 INFO - 'name': 'check_screen_resolution'},), 06:35:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:35:03 INFO - 'cmd': ('bash', 06:35:03 INFO - '-c', 06:35:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:35:03 INFO - 'enabled': True, 06:35:03 INFO - 'halt_on_failure': False, 06:35:03 INFO - 'name': 'check_screen_resolution'},), 06:35:03 INFO - 'run_cmd_checks_enabled': True, 06:35:03 INFO - 'suite': 'dromaeojs', 06:35:03 INFO - 'system_bits': '32', 06:35:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:03 INFO - 'title': 't-yosemite-r7-0124', 06:35:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:03 INFO - 'use_talos_json': True, 06:35:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:03 INFO - 'work_dir': 'build'} 06:35:03 INFO - [mozharness: 2017-03-15 13:35:03.403958Z] Running clobber step. 06:35:03 INFO - Running pre-action listener: _resource_record_pre_action 06:35:03 INFO - Running main action method: clobber 06:35:03 INFO - rmtree: /builds/slave/test/build 06:35:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:06 INFO - Running post-action listener: _resource_record_post_action 06:35:06 INFO - [mozharness: 2017-03-15 13:35:06.147307Z] Finished clobber step (success) 06:35:06 INFO - [mozharness: 2017-03-15 13:35:06.147512Z] Running read-buildbot-config step. 06:35:06 INFO - Running pre-action listener: _resource_record_pre_action 06:35:06 INFO - Running main action method: read_buildbot_config 06:35:06 INFO - Using buildbot properties: 06:35:06 INFO - { 06:35:06 INFO - "project": "", 06:35:06 INFO - "product": "firefox", 06:35:06 INFO - "script_repo_revision": "production", 06:35:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:35:06 INFO - "repository": "", 06:35:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:35:06 INFO - "buildid": "20170315050136", 06:35:06 INFO - "pgo_build": "False", 06:35:06 INFO - "basedir": "/builds/slave/test", 06:35:06 INFO - "buildnumber": 44, 06:35:06 INFO - "slavename": "t-yosemite-r7-0124", 06:35:06 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:35:06 INFO - "platform": "yosemite_r7", 06:35:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:35:06 INFO - "branch": "mozilla-central", 06:35:06 INFO - "repo_path": "mozilla-central", 06:35:06 INFO - "revision": "0cc9dced786cf2a3baeff707b636b4ad02637df0", 06:35:06 INFO - "stage_platform": "macosx64", 06:35:06 INFO - "builduid": "26314fa4665e4c55b5082917c34fbaa2", 06:35:06 INFO - "slavebuilddir": "test" 06:35:06 INFO - } 06:35:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 06:35:06 INFO - Running post-action listener: _resource_record_post_action 06:35:06 INFO - [mozharness: 2017-03-15 13:35:06.150716Z] Finished read-buildbot-config step (success) 06:35:06 INFO - [mozharness: 2017-03-15 13:35:06.150830Z] Running download-and-extract step. 06:35:06 INFO - Running pre-action listener: _resource_record_pre_action 06:35:06 INFO - Running main action method: download_and_extract 06:35:06 INFO - mkdir: /builds/slave/test/build/tests 06:35:06 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')]} 06:35:06 INFO - trying https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:35:06 INFO - Downloading https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/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 06:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/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 06:35:07 INFO - Downloaded 1199 bytes. 06:35:07 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:35:07 INFO - Using the following test package requirements: 06:35:07 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:35:07 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:35:07 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:35:07 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'jsshell-mac.zip'], 06:35:07 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:35:07 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:35:07 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:35:07 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:35:07 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:35:07 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:07 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:35:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:35:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:35:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:35:07 INFO - Fetch https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:35:09 INFO - Expected file size: 52472454 06:35:09 INFO - Obtained file size: 52472454 06:35:25 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 06:35:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:35:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:35:25 INFO - Fetch https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:35:27 INFO - Expected file size: 52472454 06:35:27 INFO - Obtained file size: 52472454 06:35:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:35:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:35:42 INFO - Fetch https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:35:43 INFO - Expected file size: 14404452 06:35:43 INFO - Obtained file size: 14404452 06:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:43 INFO - trying https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/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 06:35:46 INFO - Downloaded 75084275 bytes. 06:35:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:35:46 INFO - mkdir: /builds/slave/test/properties 06:35:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:46 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:46 INFO - Contents: 06:35:46 INFO - build_url:https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:35:46 INFO - Running post-action listener: _resource_record_post_action 06:35:46 INFO - Running post-action listener: set_extra_try_arguments 06:35:46 INFO - [mozharness: 2017-03-15 13:35:46.743744Z] Finished download-and-extract step (success) 06:35:46 INFO - [mozharness: 2017-03-15 13:35:46.743865Z] Running populate-webroot step. 06:35:46 INFO - Running pre-action listener: _resource_record_pre_action 06:35:46 INFO - Running main action method: populate_webroot 06:35:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:46 INFO - '--tppagecycles', 06:35:46 INFO - '7'], 06:35:46 INFO - 'tests': ['tsvgm']}}, 06:35:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:35:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:35:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:35:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['damp', 'tps']}, 06:35:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'tests': ['damp', 'tps']}, 06:35:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['dromaeo_dom']}, 06:35:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['basic_compositor_video']}, 06:35:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:35:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['a11yr', 06:35:46 INFO - 'ts_paint', 06:35:46 INFO - 'tpaint', 06:35:46 INFO - 'sessionrestore', 06:35:46 INFO - 'sessionrestore_no_auto_restore', 06:35:46 INFO - 'tabpaint']}, 06:35:46 INFO - 'other-e10s': {'tests': ['a11yr', 06:35:46 INFO - 'ts_paint', 06:35:46 INFO - 'tpaint', 06:35:46 INFO - 'sessionrestore', 06:35:46 INFO - 'sessionrestore_no_auto_restore', 06:35:46 INFO - 'tabpaint']}, 06:35:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:35:46 INFO - 'ts_paint', 06:35:46 INFO - 'tpaint', 06:35:46 INFO - 'sessionrestore', 06:35:46 INFO - 'sessionrestore_no_auto_restore', 06:35:46 INFO - 'tabpaint']}, 06:35:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:35:46 INFO - 'ts_paint', 06:35:46 INFO - 'tpaint', 06:35:46 INFO - 'sessionrestore', 06:35:46 INFO - 'sessionrestore_no_auto_restore', 06:35:46 INFO - 'tabpaint']}, 06:35:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['a11yr', 06:35:46 INFO - 'ts_paint', 06:35:46 INFO - 'tpaint', 06:35:46 INFO - 'sessionrestore', 06:35:46 INFO - 'sessionrestore_no_auto_restore', 06:35:46 INFO - 'tabpaint']}, 06:35:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['a11yr', 06:35:46 INFO - 'ts_paint', 06:35:46 INFO - 'tpaint', 06:35:46 INFO - 'sessionrestore', 06:35:46 INFO - 'sessionrestore_no_auto_restore', 06:35:46 INFO - 'tabpaint']}, 06:35:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['tsvgx', 06:35:46 INFO - 'tsvgr_opacity', 06:35:46 INFO - 'tart', 06:35:46 INFO - 'tscrollx', 06:35:46 INFO - 'cart', 06:35:46 INFO - 'tsvg_static']}, 06:35:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:35:46 INFO - 'tsvgr_opacity', 06:35:46 INFO - 'tart', 06:35:46 INFO - 'tscrollx', 06:35:46 INFO - 'cart', 06:35:46 INFO - 'tsvg_static']}, 06:35:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'talos_options': ['--disable-e10s'], 06:35:46 INFO - 'tests': ['tp5o']}, 06:35:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:35:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'talos_options': ['--disable-e10s', 06:35:46 INFO - '--xperf_path', 06:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:46 INFO - 'tests': ['tp5n']}, 06:35:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:35:46 INFO - 'talos_options': ['--xperf_path', 06:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:46 INFO - 'tests': ['tp5n']}}, 06:35:46 INFO - 'talos.zip': {'path': '', 06:35:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:46 INFO - Running post-action listener: _resource_record_post_action 06:35:46 INFO - [mozharness: 2017-03-15 13:35:46.762118Z] Finished populate-webroot step (success) 06:35:46 INFO - [mozharness: 2017-03-15 13:35:46.762249Z] Running create-virtualenv step. 06:35:46 INFO - Running pre-action listener: _resource_record_pre_action 06:35:46 INFO - Running main action method: create_virtualenv 06:35:46 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:46 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 06:35:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:46 INFO - Using real prefix '/tools/python27' 06:35:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:50 INFO - Installing pip.................done. 06:35:50 INFO - Return code: 0 06:35:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:35:50 INFO - Reading from file tmpfile_stdout 06:35:50 INFO - Output received: 06:35:50 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) 06:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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')]} 06:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:50 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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:35:50 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 06:35:50 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 06:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:50 INFO - 'HOME': '/Users/cltbld', 06:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:50 INFO - 'LOGNAME': 'cltbld', 06:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:50 INFO - 'MOZ_NO_REMOTE': '1', 06:35:50 INFO - 'NO_EM_RESTART': '1', 06:35:50 INFO - 'PAGER': '/bin/cat', 06:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:50 INFO - 'PWD': '/builds/slave/test', 06:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:50 INFO - 'SHELL': '/bin/bash', 06:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:35:50 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:50 INFO - 'USER': 'cltbld', 06:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:50 INFO - 'XPC_FLAGS': '0x0', 06:35:50 INFO - 'XPC_SERVICE_NAME': '0', 06:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:51 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 06:35:51 INFO - Cleaning up... 06:35:51 INFO - Return code: 0 06:35:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:35:51 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')]} 06:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:51 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')]} 06:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:51 INFO - 'HOME': '/Users/cltbld', 06:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:51 INFO - 'LOGNAME': 'cltbld', 06:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:51 INFO - 'MOZ_NO_REMOTE': '1', 06:35:51 INFO - 'NO_EM_RESTART': '1', 06:35:51 INFO - 'PAGER': '/bin/cat', 06:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:51 INFO - 'PWD': '/builds/slave/test', 06:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:51 INFO - 'SHELL': '/bin/bash', 06:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:35:51 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:51 INFO - 'USER': 'cltbld', 06:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:51 INFO - 'XPC_FLAGS': '0x0', 06:35:51 INFO - 'XPC_SERVICE_NAME': '0', 06:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:51 INFO - Downloading/unpacking psutil>=3.1.1 06:35:51 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 06:35:51 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 06:35:51 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 06:35:51 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 06:35:51 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 06:35:51 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 06:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:54 INFO - Installing collected packages: psutil 06:35:54 INFO - Running setup.py install for psutil 06:35:54 INFO - building 'psutil._psutil_osx' extension 06:35:54 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 06:35:55 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 06:35:55 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 06:35:55 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 06:35:55 INFO - building 'psutil._psutil_posix' extension 06:35:55 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 06:35:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:35:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:35:55 INFO - ^ 06:35:55 INFO - 1 warning generated. 06:35:55 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 06:35:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:56 INFO - Successfully installed psutil 06:35:56 INFO - Cleaning up... 06:35:56 INFO - Return code: 0 06:35:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:56 INFO - 'HOME': '/Users/cltbld', 06:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:56 INFO - 'LOGNAME': 'cltbld', 06:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:56 INFO - 'MOZ_NO_REMOTE': '1', 06:35:56 INFO - 'NO_EM_RESTART': '1', 06:35:56 INFO - 'PAGER': '/bin/cat', 06:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:56 INFO - 'PWD': '/builds/slave/test', 06:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:56 INFO - 'SHELL': '/bin/bash', 06:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:35:56 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:56 INFO - 'USER': 'cltbld', 06:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:56 INFO - 'XPC_FLAGS': '0x0', 06:35:56 INFO - 'XPC_SERVICE_NAME': '0', 06:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:35:59 INFO - Installing collected packages: mozsystemmonitor 06:35:59 INFO - Running setup.py install for mozsystemmonitor 06:35:59 INFO - Successfully installed mozsystemmonitor 06:35:59 INFO - Cleaning up... 06:35:59 INFO - Return code: 0 06:35:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:35:59 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')]} 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 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')]} 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:00 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 06:36:00 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 06:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:00 INFO - 'HOME': '/Users/cltbld', 06:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:00 INFO - 'LOGNAME': 'cltbld', 06:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:00 INFO - 'MOZ_NO_REMOTE': '1', 06:36:00 INFO - 'NO_EM_RESTART': '1', 06:36:00 INFO - 'PAGER': '/bin/cat', 06:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:00 INFO - 'PWD': '/builds/slave/test', 06:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:00 INFO - 'SHELL': '/bin/bash', 06:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:00 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:00 INFO - 'USER': 'cltbld', 06:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:00 INFO - 'XPC_FLAGS': '0x0', 06:36:00 INFO - 'XPC_SERVICE_NAME': '0', 06:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:00 INFO - Downloading/unpacking jsonschema==2.5.1 06:36:00 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 06:36:00 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 06:36:00 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 06:36:00 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 06:36:00 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 06:36:00 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 06:36:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:03 INFO - warning: no files found matching '*.txt' 06:36:03 INFO - no previously-included directories found matching 'build' 06:36:03 INFO - no previously-included directories found matching 'dist' 06:36:03 INFO - no previously-included directories found matching '.git*' 06:36:03 INFO - Installing collected packages: jsonschema, functools32 06:36:03 INFO - Running setup.py install for functools32 06:36:03 INFO - warning: no files found matching '*.txt' 06:36:03 INFO - no previously-included directories found matching 'build' 06:36:03 INFO - no previously-included directories found matching 'dist' 06:36:03 INFO - no previously-included directories found matching '.git*' 06:36:03 INFO - Successfully installed jsonschema functools32 06:36:03 INFO - Cleaning up... 06:36:03 INFO - Return code: 0 06:36:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:03 INFO - 'HOME': '/Users/cltbld', 06:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:03 INFO - 'LOGNAME': 'cltbld', 06:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:03 INFO - 'MOZ_NO_REMOTE': '1', 06:36:03 INFO - 'NO_EM_RESTART': '1', 06:36:03 INFO - 'PAGER': '/bin/cat', 06:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:03 INFO - 'PWD': '/builds/slave/test', 06:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:03 INFO - 'SHELL': '/bin/bash', 06:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:03 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:03 INFO - 'USER': 'cltbld', 06:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:03 INFO - 'XPC_FLAGS': '0x0', 06:36:03 INFO - 'XPC_SERVICE_NAME': '0', 06:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:36:04 INFO - Cleaning up... 06:36:04 INFO - Return code: 0 06:36:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:04 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')]} 06:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:04 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')]} 06:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:04 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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:04 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 06:36:04 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 06:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:04 INFO - 'HOME': '/Users/cltbld', 06:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:04 INFO - 'LOGNAME': 'cltbld', 06:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:04 INFO - 'MOZ_NO_REMOTE': '1', 06:36:04 INFO - 'NO_EM_RESTART': '1', 06:36:04 INFO - 'PAGER': '/bin/cat', 06:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:04 INFO - 'PWD': '/builds/slave/test', 06:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:04 INFO - 'SHELL': '/bin/bash', 06:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:04 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:04 INFO - 'USER': 'cltbld', 06:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:04 INFO - 'XPC_FLAGS': '0x0', 06:36:04 INFO - 'XPC_SERVICE_NAME': '0', 06:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:08 INFO - Downloading docopt-0.6.1.tar.gz 06:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:08 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:08 INFO - Running setup.py install for blobuploader 06:36:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:08 INFO - Running setup.py install for requests 06:36:09 INFO - Running setup.py install for docopt 06:36:09 INFO - Successfully installed blobuploader requests docopt 06:36:09 INFO - Cleaning up... 06:36:09 INFO - Return code: 0 06:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:09 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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:09 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 06:36:09 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 06:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:09 INFO - 'HOME': '/Users/cltbld', 06:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:09 INFO - 'LOGNAME': 'cltbld', 06:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:09 INFO - 'MOZ_NO_REMOTE': '1', 06:36:09 INFO - 'NO_EM_RESTART': '1', 06:36:09 INFO - 'PAGER': '/bin/cat', 06:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:09 INFO - 'PWD': '/builds/slave/test', 06:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:09 INFO - 'SHELL': '/bin/bash', 06:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:09 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:09 INFO - 'USER': 'cltbld', 06:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:09 INFO - 'XPC_FLAGS': '0x0', 06:36:09 INFO - 'XPC_SERVICE_NAME': '0', 06:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-fYh6Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Tlof4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Sy7PNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-vqbUwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-EjRsYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-MqnM96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-W4Rp1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-dkFYAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-8Xkx4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jsn84w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ST6tHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wqmm9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-E3SC8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zopyIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-6JshUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Rw5BBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-w9hZOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:11 INFO - Running setup.py install for manifestparser 06:36:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:11 INFO - Running setup.py install for mozcrash 06:36:11 INFO - Running setup.py install for mozdebug 06:36:11 INFO - Running setup.py install for mozdevice 06:36:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:11 INFO - Running setup.py install for mozfile 06:36:12 INFO - Running setup.py install for mozhttpd 06:36:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Running setup.py install for mozinfo 06:36:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Running setup.py install for mozInstall 06:36:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Running setup.py install for mozleak 06:36:12 INFO - Running setup.py install for mozlog 06:36:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Running setup.py install for moznetwork 06:36:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:12 INFO - Running setup.py install for mozprocess 06:36:13 INFO - Running setup.py install for mozprofile 06:36:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:13 INFO - Running setup.py install for mozrunner 06:36:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:13 INFO - Running setup.py install for mozscreenshot 06:36:13 INFO - Running setup.py install for moztest 06:36:13 INFO - Running setup.py install for mozversion 06:36:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:13 INFO - Cleaning up... 06:36:13 INFO - Return code: 0 06:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:13 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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:13 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 06:36:13 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 06:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:13 INFO - 'HOME': '/Users/cltbld', 06:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:13 INFO - 'LOGNAME': 'cltbld', 06:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:13 INFO - 'MOZ_NO_REMOTE': '1', 06:36:13 INFO - 'NO_EM_RESTART': '1', 06:36:13 INFO - 'PAGER': '/bin/cat', 06:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:13 INFO - 'PWD': '/builds/slave/test', 06:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:13 INFO - 'SHELL': '/bin/bash', 06:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:13 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:13 INFO - 'USER': 'cltbld', 06:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:13 INFO - 'XPC_FLAGS': '0x0', 06:36:13 INFO - 'XPC_SERVICE_NAME': '0', 06:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-M9ynJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-IUD0PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-d425dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-DMmirJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-3qaZjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-AjtQnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-D0lvxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:14 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)) 06:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:14 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-27HVxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qrAUtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-T1qEAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-xE7x0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-AUzp8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-LoXgDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-1QXSyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wG7Zp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-PlRvG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:15 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)) 06:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:15 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-fTalqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:16 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)) 06:36:16 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)) 06:36:16 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)) 06:36:16 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)) 06:36:16 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)) 06:36:16 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)) 06:36:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:18 INFO - Downloading blessings-1.6.tar.gz 06:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:18 INFO - Installing collected packages: blessings 06:36:18 INFO - Running setup.py install for blessings 06:36:18 INFO - Successfully installed blessings 06:36:18 INFO - Cleaning up... 06:36:19 INFO - Return code: 0 06:36:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:19 INFO - Reading from file tmpfile_stdout 06:36:19 INFO - Current package versions: 06:36:19 INFO - blessings == 1.6 06:36:19 INFO - blobuploader == 1.2.4 06:36:19 INFO - docopt == 0.6.1 06:36:19 INFO - functools32 == 3.2.3-2 06:36:19 INFO - jsonschema == 2.5.1 06:36:19 INFO - manifestparser == 1.1 06:36:19 INFO - mozInstall == 1.12 06:36:19 INFO - mozcrash == 1.0 06:36:19 INFO - mozdebug == 0.1 06:36:19 INFO - mozdevice == 0.49 06:36:19 INFO - mozfile == 1.2 06:36:19 INFO - mozhttpd == 0.7 06:36:19 INFO - mozinfo == 0.9 06:36:19 INFO - mozleak == 0.1 06:36:19 INFO - mozlog == 3.4 06:36:19 INFO - moznetwork == 0.27 06:36:19 INFO - mozprocess == 0.25 06:36:19 INFO - mozprofile == 0.28 06:36:19 INFO - mozrunner == 6.13 06:36:19 INFO - mozscreenshot == 0.1 06:36:19 INFO - mozsystemmonitor == 0.3 06:36:19 INFO - moztest == 0.8 06:36:19 INFO - mozversion == 1.4 06:36:19 INFO - psutil == 3.1.1 06:36:19 INFO - requests == 1.2.3 06:36:19 INFO - wsgiref == 0.1.2 06:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:19 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 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:19 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 06:36:19 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 06:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:19 INFO - 'HOME': '/Users/cltbld', 06:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:19 INFO - 'LOGNAME': 'cltbld', 06:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:19 INFO - 'MOZ_NO_REMOTE': '1', 06:36:19 INFO - 'NO_EM_RESTART': '1', 06:36:19 INFO - 'PAGER': '/bin/cat', 06:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:19 INFO - 'PWD': '/builds/slave/test', 06:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:19 INFO - 'SHELL': '/bin/bash', 06:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:19 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:19 INFO - 'USER': 'cltbld', 06:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:19 INFO - 'XPC_FLAGS': '0x0', 06:36:19 INFO - 'XPC_SERVICE_NAME': '0', 06:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 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)) 06:36:19 INFO - Cleaning up... 06:36:19 INFO - Return code: 0 06:36:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103fdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fe1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc14d8870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, '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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 06:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:19 INFO - 'HOME': '/Users/cltbld', 06:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:19 INFO - 'LOGNAME': 'cltbld', 06:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:19 INFO - 'MOZ_NO_REMOTE': '1', 06:36:19 INFO - 'NO_EM_RESTART': '1', 06:36:19 INFO - 'PAGER': '/bin/cat', 06:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:19 INFO - 'PWD': '/builds/slave/test', 06:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:19 INFO - 'SHELL': '/bin/bash', 06:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:19 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:19 INFO - 'USER': 'cltbld', 06:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:19 INFO - 'XPC_FLAGS': '0x0', 06:36:19 INFO - 'XPC_SERVICE_NAME': '0', 06:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:36:19 INFO - Cleaning up... 06:36:19 INFO - Return code: 0 06:36:19 INFO - Running post-action listener: _resource_record_post_action 06:36:19 INFO - Running post-action listener: _start_resource_monitoring 06:36:19 INFO - Starting resource monitoring. 06:36:19 INFO - [mozharness: 2017-03-15 13:36:19.930829Z] Finished create-virtualenv step (success) 06:36:19 INFO - [mozharness: 2017-03-15 13:36:19.931794Z] Running install step. 06:36:19 INFO - Running pre-action listener: _resource_record_pre_action 06:36:19 INFO - Running main action method: install 06:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:20 INFO - Reading from file tmpfile_stdout 06:36:20 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:20 INFO - Reading from file tmpfile_stdout 06:36:20 INFO - Output received: 06:36:20 INFO - Usage: mozinstall [options] installer 06:36:20 INFO - Options: 06:36:20 INFO - -h, --help show this help message and exit 06:36:20 INFO - -d DEST, --destination=DEST 06:36:20 INFO - Directory to install application into. [default: 06:36:20 INFO - "/builds/slave/test"] 06:36:20 INFO - --app=APP Application being installed. [default: firefox] 06:36:20 INFO - mkdir: /builds/slave/test/build/application 06:36:20 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'] 06:36:20 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 06:36:40 INFO - Reading from file tmpfile_stdout 06:36:40 INFO - Output received: 06:36:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:36:40 INFO - Running post-action listener: _resource_record_post_action 06:36:40 INFO - [mozharness: 2017-03-15 13:36:40.409561Z] Finished install step (success) 06:36:40 INFO - [mozharness: 2017-03-15 13:36:40.409731Z] Running run-tests step. 06:36:40 INFO - Running pre-action listener: _resource_record_pre_action 06:36:40 INFO - Running main action method: run_tests 06:36:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:36:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:36:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:36:40 INFO - 2017-03-15 06:36:40.424 screenresolution[1624:7328] starting screenresolution argv=screenresolution get 06:36:40 INFO - 2017-03-15 06:36:40.427 screenresolution[1624:7328] Display 0: 1600x1200x32@60 06:36:40 INFO - 2017-03-15 06:36:40.432 screenresolution[1625:7330] starting screenresolution argv=screenresolution list 06:36:40 INFO - Available Modes on Display 0 06:36:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:36:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:36:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:36:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:36:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:36:40 INFO - Intel Iris: 06:36:40 INFO - Chipset Model: Intel Iris 06:36:40 INFO - Type: GPU 06:36:40 INFO - Bus: Built-In 06:36:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:36:40 INFO - Vendor: Intel (0x8086) 06:36:40 INFO - Device ID: 0x0a2e 06:36:40 INFO - Revision ID: 0x0009 06:36:40 INFO - Displays: 06:36:40 INFO - Display: 06:36:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:36:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:36:40 INFO - Display Serial Number: 1600x1200 60 06:36:40 INFO - Main Display: Yes 06:36:40 INFO - Mirror: Off 06:36:40 INFO - Online: Yes 06:36:40 INFO - Rotation: Supported 06:36:40 INFO - Return code: 0 06:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:40 INFO - Python 2.7.3 06:36:40 INFO - Return code: 0 06:36:40 INFO - grabbing minidump binary from tooltool 06:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:40 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 0x103dbcd30>, '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 0x103ce3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103db1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:40 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 06:36:40 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 06:36:40 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 06:36:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:40 INFO - Return code: 0 06:36:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:36:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:40 INFO - ENV: RUST_BACKTRACE is now 1 06:36:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:36:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:40 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/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 06:36:40 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/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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 06:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPLvzI3VAp/Render', 06:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:40 INFO - 'HOME': '/Users/cltbld', 06:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:40 INFO - 'LOGNAME': 'cltbld', 06:36:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:40 INFO - 'MOZ_NO_REMOTE': '1', 06:36:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:40 INFO - 'NO_EM_RESTART': '1', 06:36:40 INFO - 'PAGER': '/bin/cat', 06:36:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:40 INFO - 'PWD': '/builds/slave/test', 06:36:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:40 INFO - 'RUST_BACKTRACE': '1', 06:36:40 INFO - 'SHELL': '/bin/bash', 06:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CLOihtTB9Z/Listeners', 06:36:40 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 06:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:40 INFO - 'USER': 'cltbld', 06:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:40 INFO - 'XPC_FLAGS': '0x0', 06:36:40 INFO - 'XPC_SERVICE_NAME': '0', 06:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:40 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/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 06:36:41 INFO - mozversion application_buildid: 20170315050136 06:36:41 INFO - mozversion application_changeset: 0cc9dced786cf2a3baeff707b636b4ad02637df0 06:36:41 INFO - mozversion application_display_name: Nightly 06:36:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:41 INFO - mozversion application_name: Firefox 06:36:41 INFO - mozversion application_remotingname: firefox 06:36:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:36:41 INFO - mozversion application_vendor: Mozilla 06:36:41 INFO - mozversion application_version: 55.0a1 06:36:41 INFO - mozversion platform_buildid: 20170315050136 06:36:41 INFO - mozversion platform_changeset: 0cc9dced786cf2a3baeff707b636b4ad02637df0 06:36:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:36:41 INFO - mozversion platform_version: 55.0a1 06:36:41 INFO - using testdate: 1489585001 06:36:41 INFO - actual date: 1489585001 06:36:41 INFO - starting webserver on 'localhost:49242' 06:36:41 INFO - SUITE-START | Running 2 tests 06:36:41 INFO - TEST-START | dromaeo_css 06:36:41 INFO - operating with platform_type : mac_ 06:36:41 INFO - Initialising browser for dromaeo_css test... 06:36:41 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpLJE_64/profile http://localhost:49242/getInfo.html) 06:36:43 INFO - PID 1635 | __metrics Screen width/height:1600/1200 06:36:43 INFO - PID 1635 | colorDepth:24 06:36:43 INFO - PID 1635 | Browser inner width/height: 1024/689 06:36:43 INFO - PID 1635 | __metrics 06:36:43 INFO - PID 1635 | 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" 06:36:43 INFO - PID 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:44 INFO - TEST-INFO | 1635: exit 0 06:36:44 INFO - Browser initialized. 06:36:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:36:44 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpLJE_64/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:56 INFO - PID 1637 | RSS: Main: 233394176 06:36:56 INFO - PID 1637 | 06:40:00 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 06:40:02 INFO - PID 1637 | RSS: Main: 370446336 06:40:02 INFO - PID 1637 | 06:41:46 INFO - PID 1637 | ************************* 06:41:46 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 06:41:46 INFO - PID 1637 | 06:41:46 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:41:46 INFO - PID 1637 | Full stack: 06:41:46 INFO - PID 1637 | ************************* 06:43:05 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 06:43:06 INFO - PID 1637 | RSS: Main: 364773376 06:43:06 INFO - PID 1637 | 06:46:08 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 06:46:09 INFO - PID 1637 | RSS: Main: 349323264 06:46:09 INFO - PID 1637 | 06:49:11 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 06:49:12 INFO - PID 1637 | RSS: Main: 327651328 06:49:12 INFO - PID 1637 | 06:52:15 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 06:52:16 INFO - PID 1637 | RSS: Main: 338935808 06:52:16 INFO - PID 1637 | 06:55:19 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 06:55:20 INFO - PID 1637 | RSS: Main: 554987520 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | __start_tp_report 06:55:20 INFO - PID 1637 | _x_x_mozilla_page_load 06:55:20 INFO - PID 1637 | _x_x_mozilla_page_load_details 06:55:20 INFO - PID 1637 | |i|pagename|runs| 06:55:20 INFO - PID 1637 | |0;dojo.html;2869.6126022986896;3071.2168397058745;3358.194033431976;3367.4780409036593;3378.510116033177;4627.768611569425;5678.091505359143;5742.712864356781;5784.68184249866;5810.389909059546;5688.288963879515;5759.856003599912;5760;5762.769489220426;5811.4479124483105;4746.579320720225;5119.795208191668;5144.7170405627585;5200.713960732158;5205.427402985669;5314.681119132845;5345.7594408251525;5348.251244825728;5362.65142765719;5367.75845086972;5154.201098829687;5185.818496352647;5188.092083885343;5229.660072095302;5298.708571028592;5244.029854476896;5245.606579506514;5254.448282930313;5313.38896026958;5325.8934821303355;5128.076946149691;5206.635535512516;5209.869753256199;5236.162214045772;5255.0540902637895;5585.2459917910965;5629.9437005629825;5707.74315155819;5714.371419143891;5737.2254745609225;4996.4254110777365;6188.195534580521;6252.87494250117;6300.086487459339;6325.051242313643;6222.533310001722;6265.248170219603;6288.528360372945;6291.213598300213;6306.684665766693;5778.959787238337;5858.12128180772;5869;5870.354261031283;5891.293044834647;6236.314005459396;6249.6562689052535;6258.906116408258;6287.685615719287;6290.150829638032;6183.227096612924;6213.502919766408;6226.533010024266;6229.345918678564;6232.594881332699;6294.150289710922;6296.905546416808;6303.747850086037;6331;6337.683115844189;6125.173101631222;6132.539076726543;6133.407859146218;6207.441330280206;6299.811005669837;6263;6302.464290535356;6306.337834527309;6309.400606942333;6316.9368306317265;4890.535399137077;5010.498950105033;5027.245913112989;5036.320096786887;5071.923921141186;4438.201123797748;4446.9777651111535;4462.464504259445;4491.281394976788;4501.549845015472;5761.452661997104;5768.394318596571;5771.394003629643;5782.624129431573;5785.27684039495;6162.168107305546;6238.220222472191;6244.250689917239;6249.187605611241;6250.406211409909;5765.279340082489;5774.595778295479;5778.3643799182055;5790.334111577223;5791.247137872049;5429.945700543023;5466.180072989004;5479.4520547944885;5490.423505531941;5492;6304.432601065926;6311.147995020613;6316.684165791692;6331.683415829098;6335.746570137143;6246.031865060922;6281.4660753834605;6293.559450838397;6302.716377763103;6322.272938612118;6376.776812811529;6395.6482393468805;6406.231252249573;6418.518611104092;6427.3251308611925;6127.3566275540425;6266.592671476339;6277.15258440123;6283.183186185949;6292.276388215414;6203.4416902479;6244;6249.78125765596;6263.592866463665;6305.4009869062365;5216.869578260574;5608.831735047955;6095.634261944298;6125.540584456273;6135.967692822179;5993.580449368676;6111.1444397785235;6127.816165515042;6155.446009859134;6166.722497487534;5789.92886316016;5847.035239185657;5856.472917437451;6008.849778755566;6013.609115407485;6113.415495409368;6167.414095660905;6204.7828326008375;6212.409821066992;6227.314995350598;5985.132155837467;6003.8198854034445;6007;6007.158997740233;6063.242094738158 06:55:20 INFO - PID 1637 | |1;ext.html;768.9884651730223;851.2551517422255;864.5547543015348;869.1873098652765;872.1670804381816;37887.81056094719;38649.22701545968;38661.84014479563;38701.80649096754;38708.419373709345;37001;37302.47206738817;37403;37517.24965500695;37575.81212093942;7348.301911318416;7522.172561018284;7732.922670773277;7905.090914544843;7930.682772689085;10638.255322127454;10827.83758243627;11076.944615276952;11089.27919685222;11093.667189984313;9977.800443991116;11211.383373914432;11270.211085224038;11278.436078196099;11302.208845380826;7311.378532824663;7486.700531978714;11196.328220306767;11227.326360418401;11235.325880447199;9170.312226582966;10671.03960643538;10865.45672716361;10894.237403381767;10908.400037997906;38249;38569;38667.613323866964;38673.613263867286;38735.61264387348;3226.9677303226904;3821.5605205401457;3854.286956912952;3873.9806300968316;3973.7417067890783;28081.719182808116;28571.85714071437;29195.85402072976;29221.41557168845;29341.413171736447;3063.6476805167467;3210.2776875202894;3223.403670320998;3235.223546348883;3240.141362538929;251593;253448;311696.99999999773;312909.30636040476;313582;40300.99247518777;40817.387739183934;40817.979550511474;48374.75812620914;52285.47714522882;52508.73745631324;52943.47056529386;52949.47050529523;53123.20315195275;53223.467765322624;14681.650935850426;14802.407903683947;14833.480828170963;14850.925745371203;14896.255187240595;11899.107566932515;11951.92432681063;11989.820152697717;11996.64010079699;12004;13929.86070139306;14050.297485125702;14079.718405632035;14122.03437278183;14191.78712319316;5837.9124313135335;5873.970630146822;5920.082387229986;5928.199693041471;5937.940620593825;1123.292325834719;1132.2923173016864;1132.5186795611833;1148.035650053942;1177.587844254521;24791.5041699165;27153;27309.590356144672;27471.725282747317;27590.862045690046;1220.17638094286;1233.2292317301687;1255.4162314523608;1277.6933535951305;1286.395394164741;13383.933080334536;13872.375743091585;14205.147691138565;14207.573772786833;14250;456437;459297;461329;462005;462344;57597.712011439675;57967;58010.70994645;58053.4194658048;58066;1355.2749279135614;1436.4469679173385;1436.5762100180682;1441.5531185332582;1458.6936743283818;24351.26946191617;25096.498070038862;25362.873185634693;26737.732622673524;26788;47812.760936195096;47846.043079137526;47886.28170577514;47910.76044619754;48110;406351;406386;407157.0695809526;407962;408530;25981.610275845498;31455.842720786248;33244.833775830964;33295;35238.11904702403;40656.59343406528;40970.1805963885;42118.73643790691;42144.78927605342;42236.577634223264;33709.83145084259;33829.154271143416;33901.98294051182;34967.30065398729;35277;33725.49411758874;33778.15554611154;34792.652073478945;35057.474137888465;36186.45720314145;35624.46563301501;36286.092847677966;36323;36370.4544431839;36392;22479.88760056189;28609.570856436752;30159.944401945828;31557.36885262328;31629.051128466184;23290.76709232886;23918.9316793646;24062.759372406752;24224.78876056155;24270 06:55:20 INFO - PID 1637 | |2;jquery.html;398.3148983747954;398.32086292870656;416.8645190313148;420.32537776868134;422.9725067870588;20137.899310503446;20769.480762980915;21020;21249.893750531224;21463.67804482932;20829;20874.37376878692;21083.68374474384;21404.678929816026;21675.566488670218;6530.412262896339;6887.827804304908;6889.4832887533385;6901;6904.792856214296;6023.337432882401;6497.805065848009;6564.916788729878;6714.764983225588;6728.461723062143;6695.962125870498;6786.355296246848;6788.592684438925;6789.287124851893;6800.285969973156;6628.536002479805;6732.730690772363;6780.355866192728;6784.8303792405095;6794.116764820591;6588.505862060317;6620.536562440631;7291.234420385889;7580.658870350848;7622.627926973142;25963.610545841828;27857.72142278592;28061.85969070162;28117.156485305473;28349.858250708614;2772.5702516110036;2879.1074766822353;2900.3329234276025;2900.5939168516425;2900.76793856491;15024.924875375662;15506.5348039559;15917.52247432579;16476.588085297964;16713.49859504217;1990.99004504978;2036.4603380104284;2059.6086743518686;2063.3912995666315;2085.374387683704;80391.99999999942;92012.53993729988;101290;110065;154863;17239.56901077458;19849.801501985083;20413.69379459309;21949.122035118417;22257.888710556344;37205;37253.81373093172;37368.81315593405;37454;37456.62543374586;8466.957665211634;8586.484810911365;9942.900570994198;10207.438590877424;10493.632722854816;8265.421420500506;8284.627191776384;8294.958525207456;8434.704785332484;8475.660973561111;8389.706360277361;9516.667666526691;9998.850017249748;10588.364698118137;10644;3765.8325918965206;3963.92072158561;4105.137921036616;4175.853845115406;4187.497500299984;833.5248908122312;971.8833739951251;1008.6233828057902;1012.9290949633455;1023.4831410137833;21935.232266870582;22614.547709045728;22666.979985900674;22672;22719.318420447413;839.9538025408661;981.9459929703935;990.6483198464585;1008.7730260691286;1017.1100287248657;9360.630173137664;10513.317869140901;11478.288633461154;11635.243709158878;11676.70808229784;651152;651187;688202;706197.9731722758;710826;99236.50381748189;116363;151398;153798.2310088465;158451.20774396285;1218.622227109599;1222.6698791326291;1251.3180316727223;1263.2294300476701;1276.1003492537739;15228.695426091195;18008.909955450665;18572.628547429245;21523.461913452287;21581.813000285136;49646;59803.70098149481;61385.386146137964;62195.68902155641;62557;83686.58156709178;85311;86165.56917215374;86211.70682439643;86991.13008869831;9880.901190987997;11109.388983605655;11688.94155529217;11872.881271187178;11893.21601759743;12734.426950787052;12940.741185176432;13038.348082596021;13197.670058248237;13409.731805364034;10983.83524247121;11029.117670586495;11111.666650000512;11215.775684486427;11244.775104498029;11104.111671066134;11175.608853690406;11417.60038398652;11444.656660300205;11565.595204167814;10973;11171.21801473889;11451.08391328675;11568.826467603161;11618.360990145624;11300.756916739316;11303.660890173307;11708.238964467282;11720.589779357682;11746.647600571996;11123.443827808738;11158.274712143684;11322.773544528898;11326.943365283121;11404.771904562029 06:55:20 INFO - PID 1637 | |3;mootools.html;1440.2078856628852;1557.3692654474942;1566.1934103936467;1598.432556442463;1603.118284943281;10471.895281047187;10961;10962.28745131567;10962.506687199075;10981.615643452471;10412.843807342895;10778.784424311509;10784.97542733441;10816.945915270413;10850.620228292011;2289.9656505152393;2332.4285550040263;2335;2335.3577766114367;2335.754745751697;2273.897674604647;2318.6637937499054;2318.7217533895955;2321.8374713770045;2327.813774898004;1876.7278744582095;2215.3464727905307;2234.7988681018705;2237.2505210754334;2244.36035729817;2257.683924250606;2284.3946354216146;2284.931452056441;2285.6228722260807;2285.622872226089;1847.7320788485729;2301.9526115617355;2304.9308520744403;2314.6528020796845;2320.1763374002326;10848.349099054081;10925.125989920787;10930.070943969773;10944.671659850217;10944.890551094546;4775.2359622460235;5783.913241301384;5787.768489260425;5797.246357973479;5821.7380217890295;3089.891853785129;3245.334706385185;3579.2483578448555;3593.9101522461888;3600.5499312585926;1123.3147779854364;1128.751674631588;1185.3302883870585;1185.4453652379136;1194.994025029878;15288.388464461408;15390.615234619112;15455.304511296907;15472.839537034655;15507.844921550753;4344.847930322424;4559.6808223424705;4601.792919318638;4693.460252070987;4697.577218050392;11240.381779002233;11241.55033798639;11253.043491303331;11253.268537545033;11265.324080555192;5655.981923253854;5665.461781130786;5668.26312579362;5679.403662615366;5696.8006119785605;4996.375453068366;5036.546710796046;5139.897202055938;5195.142801437721;5285.497877701612;3670.284294562535;3756.8309426075343;3775.244951009754;3816.5497111097607;3835.884923452301;1009.7627057641448;1012.1649639047815;1024.8052869954686;1025.6820385680314;1027.0038063078803;892.8705337725993;918.4672889723944;927.1423932862076;935.5654199096235;974.1281553010016;6409.284131957615;6410.967945160244;6653.2681405045405;6722.764703235363;6806.659667016629;923.8660394242797;940.5955439161089;959.2469911119738;959.5490119643756;977.5744617373548;3840;3879.80600969956;3969.2458432897656;3998.260321840469;4003.479547658844;13235.94112471;13332.73334533304;13737.931310343385;13740.65648358799;13743.656408589864;11842.822357664641;13335.93332033353;13582.388792504362;13617.455301788015;13627;7960.681572737141;8198.795030124294;8722.386358523567;9911.900880991097;9935.602575896883;6499.350064993463;6588.341165883373;6704.932950670431;6754.358335958076;6781.11845460087;11592;12132.454039568063;12147.81778273309;12154.878451215729;12159.878401215874;10512.632057877938;11921.34432606215;12282.570110046105;12399.75200496003;12447.377631118588;8175.119722463748;8367.079621241537;8493.787655308419;8625.180607842245;8627.827443451222;9458.95270523643;9636.807263854824;9651.565679544297;9681.806363872824;9706.417614942844;8364;8400.49597024156;8420.326373889951;8469.237768600855;8621.361941231145;8261.917380826115;8302.626381812712;8312.958435207785;8359.122292159478;8367.288780453486;7265.382442492447;7414.406847452299;7422.628868556659;7426.554406735613;7432.777016689508;5443.183522471661;5526.861828454321;5594.664320140641;5636.210930469655;5675.432456754292;5504.366997795145;5652.3217213934595;5665.263515742927;5714.885702286014;5761.654300741969 06:55:20 INFO - PID 1637 | |4;prototype.html;385.5912732503546;386.42615715662254;387.98836034918946;391.85893078491756;398.31489837479523;5691.601587888849;5714.914276285859;5761.4814666679995;5765.625234359774;5806.274215723035;4400.691951563392;5517.668939863611;5662.37713851476;5668.886622267562;5700.116481945305;4394.780260986954;4402.295632698769;4422.5577442255835;4434.401355816972;4442.777861106948;3967.246223217594;4099.528554216258;4413.58070983256;4421.425214722081;4461.598456138947;3621.8370173342264;3936.6260205280596;4284.614384705376;4413.7558894212725;4418.712783669067;3598.352296586613;4379.8467053653285;4392.692511524195;4399.318105693623;4423.248047831877;3906.257811015926;3910.296146693594;3923.3330333843314;3925.3523168677134;3927.998360418104;5378.946210537883;5541.778328866841;5554.805986557745;5579;5594.356648985378;4224.197402493516;4543.681942264043;5143.71709555978;5203.427622961472;5227.921581176285;6162.8767424651705;6165.841955315604;6171.722272497748;6173.351798061184;6184.96907515464;3394.915127121817;4166.0834616384345;4368.716033457847;4395.208862404766;4404.933925991113;6216.751329946796;6389.744410223586;6426.2931077581425;6432.710528026157;6462.838429039265;4778.163821331323;4785.947091639834;5250.553702935294;5277.656952298088;5308.124159513714;4515.367848501212;4804.231322988305;4832.903341933142;5221.921671174935;5456.345238571397;5718.771249149988;5723.713814309268;5752.511036561856;5768;5776.624519406309;5999.700014999233;6214.161088253119;6224.190855188887;6227.470664993436;6288.213973253343;1878.1736036144052;1928.4793105861338;1928.4889504281377;1933.7679478462674;1936.951576210606;1330.9134906231063;1402.214759734552;1459.737247295497;1524.3216768537893;1569.6154442161744;5612.410696876851;5855.970720146372;5867.513874527245;5880.852978675567;5884.086787532458;5231.738413079331;6372.406898275432;6393.552451328455;6407.935920640734;6459.418652321314;4902.754862256944;5574.331080270394;5811.970940145272;5823.912641310384;5920.4967577755515;2771.362586605092;2795.916122516328;3303.487959366302;3307.6030876295;3329.5183643278992;5569.777208911679;6342;6469.417752402306;6630.701618427182;6693.661267746373;6489.253735820346;6521.836954076091;6543.967280163664;6560;6584.5061620378665;6104.901117798839;6346.333634968447;6644;6660.73534998103;6665.667615765043;5454.10007348783;6059.242594675666;6306.306306306211;6333.606606546552;6361.491080713439;5974.416779553509;6189.907151392823;6297.590656607306;6316.7157477914525;6319.8104056878365;6189.6286222826775;6624.436922861611;6636.469082473487;6660.602183214136;6762.391384775394;4357.714474230173;4884.9511504884495;4994.600431965507;5032.672876263031;5043.798248070036;6204.689765511796;6405.263394709668;6483.351664833479;6494.265797166554;6500.837479063061;5972.25346831646;6158.353372895782;6230.968845155927;6237.282712488122;6260.68696565179;4586.747728874944;5714.5999780015;5814.215080964016;6230;6238.500919926304;5879.73541190656;6077.361877002851;6097.695115244309;6127.571070025234;6193.071039344134;6232.657203853832;6237.28271248794;6239.625622462667;6239.656818875005;6242.188515492957;5068.315777370008;5555.583331250092;5798.796457346181;6103.694815259308;6120.479759220338 06:55:20 INFO - PID 1637 | |5;yui.html;714.9571025738453;719.1011235955057;728.582906247349;767.9785884773252;834.3908946469078;14947.775783363244;15678.686426271468;15705.371785128595;15711.607209819746;17583.73624395635;16531.91734041331;17040.403585874497;17153.05658188799;17335;17342.653146937053;952.2477242978039;978.9902100979006;984.2027957354566;985.5072463768116;986.1371300112402;960.2462067277189;982.1651596143292;986.2307400227797;988.3229987458614;992.5087081894472;1047.282611411182;1047.481496659151;1048.6487026846016;1048.7273308939693;1050.4747626186906;1037.584966013593;1040.588967357897;1042.2027149230844;1044.0186224948525;1047.1675018360384;768.8846672999039;770.3606007014165;771.8533478639097;772.996135019327;781.3709963479397;15266.007709498957;15611.063336199864;15731.134787586678;15999.360025598962;16164.838351616569;14277.14337139775;14560.344784484723;14726.116433014053;14726.70546589073;14756.262186890719;11676.532938682443;11767.352795596238;11851.881481185164;11946.402679865972;11986.400679966055;3657.762245454037;3716.650056771144;3814.370628846237;3896.1428485733377;3898.3567711327596;109425;110826;111616;112075;112810.43594781973;10700.892991070144;11373.431328433546;11503.367314797599;11629.88370116305;12091.214071085351;20728.378148655564;24524.632130518057;25122.623160652605;25124.371890702878;25326.74673253244;7857.567833769198;7937.2459616336355;7951.244631759973;8015.759527214076;8196.959015204886;4266.679999000087;4271.124419493996;4311.547287534827;4334.371516130143;4352.912941741148;3495.265994141208;3542.096765324826;3551.857925682944;3552.609212986569;3564.6791788739138;581.8545363659085;582.3594046548762;583.1451290085023;586.3286536915208;589.6491587505427;635.853753636657;661.798151563768;688.7017971124467;705.1679018757812;722.6784081083972;9548.952255238679;9850.50747462624;9948.950255248823;10073.41472864366;10262.230332725076;651.5596211816455;693.3136195166749;712.1311999360771;722.9421646268286;727.1710250314645;3706.4440333950124;4250.808713607895;4361.542038085955;4630.907381852344;4857;73677;76068.23931760722;96733.5163324193;97484.0251597475;102215.48892255491;61766;78848.60575697085;81109.18890811135;81643.5917820407;82794.75807862887;52919.94160116776;74985;75423.99999999891;76506.61746691231;77073;9129.45223286605;9225.07749225072;9292.95353523228;9312.161905428544;9420.811583768424;40925.795371022956;42879.571204288804;47311;47472;48959.51040489692;61222.08166877589;61440;62247.688761557714;63016.68491657513;64414.677926610064;13326.666833328856;13338.733225335633;13491.25798081115;14070.226137562533;14164.308761479275;14230.501932432315;14577.198254095701;14589.197594132425;14619.85380146185;14665.266736663338;13410.664733381744;13503;13645.931770341085;13754.793678094637;14154;12890.806637900252;13076.803847942097;13309.134906231064;13345.199288042748;14089.084209526758;13093.672658183621;13258.53595124166;13300.800487992881;13559.45762169502;13597.728045438838;9328.720138395858;9957.601695932082;9957.950210248902;10214.540345684314;10672.466376680979;8552.014527748388;8827.779305517413;9769.56036978352;9781.217502599917;9847.162991145833 06:55:20 INFO - PID 1637 | __end_tp_report 06:55:20 INFO - PID 1637 | __start_cc_report 06:55:20 INFO - PID 1637 | _x_x_mozilla_cycle_collect,1847 06:55:20 INFO - PID 1637 | __end_cc_report 06:55:20 INFO - PID 1637 | __startTimestamp1489586120177__endTimestamp 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | ------- Summary: start ------- 06:55:20 INFO - PID 1637 | Number of tests: 6 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:5757.74 Median:5993.58 stddev:670.67 (11.2%) stddev-sans-first:633.30 06:55:20 INFO - PID 1637 | Values: 2869.6 3071.2 3358.2 3367.5 3378.5 4627.8 5678.1 5742.7 5784.7 5810.4 5688.3 5759.9 5760.0 5762.8 5811.4 4746.6 5119.8 5144.7 5200.7 5205.4 5314.7 5345.8 5348.3 5362.7 5367.8 5154.2 5185.8 5188.1 5229.7 5298.7 5244.0 5245.6 5254.4 5313.4 5325.9 5128.1 5206.6 5209.9 5236.2 5255.1 5585.2 5629.9 5707.7 5714.4 5737.2 4996.4 6188.2 6252.9 6300.1 6325.1 6222.5 6265.2 6288.5 6291.2 6306.7 5779.0 5858.1 5869.0 5870.4 5891.3 6236.3 6249.7 6258.9 6287.7 6290.2 6183.2 6213.5 6226.5 6229.3 6232.6 6294.2 6296.9 6303.7 6331.0 6337.7 6125.2 6132.5 6133.4 6207.4 6299.8 6263.0 6302.5 6306.3 6309.4 6316.9 4890.5 5010.5 5027.2 5036.3 5071.9 4438.2 4447.0 4462.5 4491.3 4501.5 5761.5 5768.4 5771.4 5782.6 5785.3 6162.2 6238.2 6244.3 6249.2 6250.4 5765.3 5774.6 5778.4 5790.3 5791.2 5429.9 5466.2 5479.5 5490.4 5492.0 6304.4 6311.1 6316.7 6331.7 6335.7 6246.0 6281.5 6293.6 6302.7 6322.3 6376.8 6395.6 6406.2 6418.5 6427.3 6127.4 6266.6 6277.2 6283.2 6292.3 6203.4 6244.0 6249.8 6263.6 6305.4 5216.9 5608.8 6095.6 6125.5 6136.0 5993.6 6111.1 6127.8 6155.4 6166.7 5789.9 5847.0 5856.5 6008.8 6013.6 6113.4 6167.4 6204.8 6212.4 6227.3 5985.1 6003.8 6007.0 6007.2 6063.2 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:53031.68 Median:33502.42 stddev:103962.30 (310.3%) stddev-sans-first:104179.89 06:55:20 INFO - PID 1637 | Values: 769.0 851.3 864.6 869.2 872.2 37887.8 38649.2 38661.8 38701.8 38708.4 37001.0 37302.5 37403.0 37517.2 37575.8 7348.3 7522.2 7732.9 7905.1 7930.7 10638.3 10827.8 11076.9 11089.3 11093.7 9977.8 11211.4 11270.2 11278.4 11302.2 7311.4 7486.7 11196.3 11227.3 11235.3 9170.3 10671.0 10865.5 10894.2 10908.4 38249.0 38569.0 38667.6 38673.6 38735.6 3227.0 3821.6 3854.3 3874.0 3973.7 28081.7 28571.9 29195.9 29221.4 29341.4 3063.6 3210.3 3223.4 3235.2 3240.1 251593.0 253448.0 311697.0 312909.3 313582.0 40301.0 40817.4 40818.0 48374.8 52285.5 52508.7 52943.5 52949.5 53123.2 53223.5 14681.7 14802.4 14833.5 14850.9 14896.3 11899.1 11951.9 11989.8 11996.6 12004.0 13929.9 14050.3 14079.7 14122.0 14191.8 5837.9 5874.0 5920.1 5928.2 5937.9 1123.3 1132.3 1132.5 1148.0 1177.6 24791.5 27153.0 27309.6 27471.7 27590.9 1220.2 1233.2 1255.4 1277.7 1286.4 13383.9 13872.4 14205.1 14207.6 14250.0 456437.0 459297.0 461329.0 462005.0 462344.0 57597.7 57967.0 58010.7 58053.4 58066.0 1355.3 1436.4 1436.6 1441.6 1458.7 24351.3 25096.5 25362.9 26737.7 26788.0 47812.8 47846.0 47886.3 47910.8 48110.0 406351.0 406386.0 407157.1 407962.0 408530.0 25981.6 31455.8 33244.8 33295.0 35238.1 40656.6 40970.2 42118.7 42144.8 42236.6 33709.8 33829.2 33902.0 34967.3 35277.0 33725.5 33778.2 34792.7 35057.5 36186.5 35624.5 36286.1 36323.0 36370.5 36392.0 22479.9 28609.6 30159.9 31557.4 31629.1 23290.8 23918.9 24062.8 24224.8 24270.0 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:39470.90 Median:22640.76 stddev:113027.29 (499.2%) stddev-sans-first:113306.29 06:55:20 INFO - PID 1637 | Values: 398.3 398.3 416.9 420.3 423.0 20137.9 20769.5 21020.0 21249.9 21463.7 20829.0 20874.4 21083.7 21404.7 21675.6 6530.4 6887.8 6889.5 6901.0 6904.8 6023.3 6497.8 6564.9 6714.8 6728.5 6696.0 6786.4 6788.6 6789.3 6800.3 6628.5 6732.7 6780.4 6784.8 6794.1 6588.5 6620.5 7291.2 7580.7 7622.6 25963.6 27857.7 28061.9 28117.2 28349.9 2772.6 2879.1 2900.3 2900.6 2900.8 15024.9 15506.5 15917.5 16476.6 16713.5 1991.0 2036.5 2059.6 2063.4 2085.4 80392.0 92012.5 101290.0 110065.0 154863.0 17239.6 19849.8 20413.7 21949.1 22257.9 37205.0 37253.8 37368.8 37454.0 37456.6 8467.0 8586.5 9942.9 10207.4 10493.6 8265.4 8284.6 8295.0 8434.7 8475.7 8389.7 9516.7 9998.9 10588.4 10644.0 3765.8 3963.9 4105.1 4175.9 4187.5 833.5 971.9 1008.6 1012.9 1023.5 21935.2 22614.5 22667.0 22672.0 22719.3 840.0 981.9 990.6 1008.8 1017.1 9360.6 10513.3 11478.3 11635.2 11676.7 651152.0 651187.0 688202.0 706198.0 710826.0 99236.5 116363.0 151398.0 153798.2 158451.2 1218.6 1222.7 1251.3 1263.2 1276.1 15228.7 18008.9 18572.6 21523.5 21581.8 49646.0 59803.7 61385.4 62195.7 62557.0 83686.6 85311.0 86165.6 86211.7 86991.1 9880.9 11109.4 11688.9 11872.9 11893.2 12734.4 12940.7 13038.3 13197.7 13409.7 10983.8 11029.1 11111.7 11215.8 11244.8 11104.1 11175.6 11417.6 11444.7 11565.6 10973.0 11171.2 11451.1 11568.8 11618.4 11300.8 11303.7 11708.2 11720.6 11746.6 11123.4 11158.3 11322.8 11326.9 11404.8 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:6517.26 Median:3713.56 stddev:4127.95 (111.2%) stddev-sans-first:4121.90 06:55:20 INFO - PID 1637 | Values: 1440.2 1557.4 1566.2 1598.4 1603.1 10471.9 10961.0 10962.3 10962.5 10981.6 10412.8 10778.8 10785.0 10816.9 10850.6 2290.0 2332.4 2335.0 2335.4 2335.8 2273.9 2318.7 2318.7 2321.8 2327.8 1876.7 2215.3 2234.8 2237.3 2244.4 2257.7 2284.4 2284.9 2285.6 2285.6 1847.7 2302.0 2304.9 2314.7 2320.2 10848.3 10925.1 10930.1 10944.7 10944.9 4775.2 5783.9 5787.8 5797.2 5821.7 3089.9 3245.3 3579.2 3593.9 3600.5 1123.3 1128.8 1185.3 1185.4 1195.0 15288.4 15390.6 15455.3 15472.8 15507.8 4344.8 4559.7 4601.8 4693.5 4697.6 11240.4 11241.6 11253.0 11253.3 11265.3 5656.0 5665.5 5668.3 5679.4 5696.8 4996.4 5036.5 5139.9 5195.1 5285.5 3670.3 3756.8 3775.2 3816.5 3835.9 1009.8 1012.2 1024.8 1025.7 1027.0 892.9 918.5 927.1 935.6 974.1 6409.3 6411.0 6653.3 6722.8 6806.7 923.9 940.6 959.2 959.5 977.6 3840.0 3879.8 3969.2 3998.3 4003.5 13235.9 13332.7 13737.9 13740.7 13743.7 11842.8 13335.9 13582.4 13617.5 13627.0 7960.7 8198.8 8722.4 9911.9 9935.6 6499.4 6588.3 6704.9 6754.4 6781.1 11592.0 12132.5 12147.8 12154.9 12159.9 10512.6 11921.3 12282.6 12399.8 12447.4 8175.1 8367.1 8493.8 8625.2 8627.8 9459.0 9636.8 9651.6 9681.8 9706.4 8364.0 8400.5 8420.3 8469.2 8621.4 8261.9 8302.6 8313.0 8359.1 8367.3 7265.4 7414.4 7422.6 7426.6 7432.8 5443.2 5526.9 5594.7 5636.2 5675.4 5504.4 5652.3 5665.3 5714.9 5761.7 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5143.16 Median:5714.76 stddev:1495.73 (26.2%) stddev-sans-first:1456.68 06:55:20 INFO - PID 1637 | Values: 385.6 386.4 388.0 391.9 398.3 5691.6 5714.9 5761.5 5765.6 5806.3 4400.7 5517.7 5662.4 5668.9 5700.1 4394.8 4402.3 4422.6 4434.4 4442.8 3967.2 4099.5 4413.6 4421.4 4461.6 3621.8 3936.6 4284.6 4413.8 4418.7 3598.4 4379.8 4392.7 4399.3 4423.2 3906.3 3910.3 3923.3 3925.4 3928.0 5378.9 5541.8 5554.8 5579.0 5594.4 4224.2 4543.7 5143.7 5203.4 5227.9 6162.9 6165.8 6171.7 6173.4 6185.0 3394.9 4166.1 4368.7 4395.2 4404.9 6216.8 6389.7 6426.3 6432.7 6462.8 4778.2 4785.9 5250.6 5277.7 5308.1 4515.4 4804.2 4832.9 5221.9 5456.3 5718.8 5723.7 5752.5 5768.0 5776.6 5999.7 6214.2 6224.2 6227.5 6288.2 1878.2 1928.5 1928.5 1933.8 1937.0 1330.9 1402.2 1459.7 1524.3 1569.6 5612.4 5856.0 5867.5 5880.9 5884.1 5231.7 6372.4 6393.6 6407.9 6459.4 4902.8 5574.3 5812.0 5823.9 5920.5 2771.4 2795.9 3303.5 3307.6 3329.5 5569.8 6342.0 6469.4 6630.7 6693.7 6489.3 6521.8 6544.0 6560.0 6584.5 6104.9 6346.3 6644.0 6660.7 6665.7 5454.1 6059.2 6306.3 6333.6 6361.5 5974.4 6189.9 6297.6 6316.7 6319.8 6189.6 6624.4 6636.5 6660.6 6762.4 4357.7 4885.0 4994.6 5032.7 5043.8 6204.7 6405.3 6483.4 6494.3 6500.8 5972.3 6158.4 6231.0 6237.3 6260.7 4586.7 5714.6 5814.2 6230.0 6238.5 5879.7 6077.4 6097.7 6127.6 6193.1 6232.7 6237.3 6239.6 6239.7 6242.2 5068.3 5555.6 5798.8 6103.7 6120.5 06:55:20 INFO - PID 1637 | 06:55:20 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:19632.49 Median:22412.08 stddev:27533.17 (122.8%) stddev-sans-first:27573.77 06:55:20 INFO - PID 1637 | Values: 715.0 719.1 728.6 768.0 834.4 14947.8 15678.7 15705.4 15711.6 17583.7 16531.9 17040.4 17153.1 17335.0 17342.7 952.2 979.0 984.2 985.5 986.1 960.2 982.2 986.2 988.3 992.5 1047.3 1047.5 1048.6 1048.7 1050.5 1037.6 1040.6 1042.2 1044.0 1047.2 768.9 770.4 771.9 773.0 781.4 15266.0 15611.1 15731.1 15999.4 16164.8 14277.1 14560.3 14726.1 14726.7 14756.3 11676.5 11767.4 11851.9 11946.4 11986.4 3657.8 3716.7 3814.4 3896.1 3898.4 109425.0 110826.0 111616.0 112075.0 112810.4 10700.9 11373.4 11503.4 11629.9 12091.2 20728.4 24524.6 25122.6 25124.4 25326.7 7857.6 7937.2 7951.2 8015.8 8197.0 4266.7 4271.1 4311.5 4334.4 4352.9 3495.3 3542.1 3551.9 3552.6 3564.7 581.9 582.4 583.1 586.3 589.6 635.9 661.8 688.7 705.2 722.7 9549.0 9850.5 9949.0 10073.4 10262.2 651.6 693.3 712.1 722.9 727.2 3706.4 4250.8 4361.5 4630.9 4857.0 73677.0 76068.2 96733.5 97484.0 102215.5 61766.0 78848.6 81109.2 81643.6 82794.8 52919.9 74985.0 75424.0 76506.6 77073.0 9129.5 9225.1 9293.0 9312.2 9420.8 40925.8 42879.6 47311.0 47472.0 48959.5 61222.1 61440.0 62247.7 63016.7 64414.7 13326.7 13338.7 13491.3 14070.2 14164.3 14230.5 14577.2 14589.2 14619.9 14665.3 13410.7 13503.0 13645.9 13754.8 14154.0 12890.8 13076.8 13309.1 13345.2 14089.1 13093.7 13258.5 13300.8 13559.5 13597.7 9328.7 9957.6 9958.0 10214.5 10672.5 8552.0 8827.8 9769.6 9781.2 9847.2 06:55:20 INFO - PID 1637 | -------- Summary: end -------- 06:55:20 INFO - PID 1637 | 06:55:20 INFO - TEST-INFO | 1637: exit 0 06:55:20 INFO - TEST-OK | dromaeo_css | took 1119885ms 06:55:20 INFO - TEST-START | kraken 06:55:20 INFO - operating with platform_type : mac_ 06:55:20 INFO - Initialising browser for kraken test... 06:55:20 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpLwKvc5/profile http://localhost:49242/getInfo.html) 06:55:23 INFO - PID 1646 | __metrics Screen width/height:1600/1200 06:55:23 INFO - PID 1646 | colorDepth:24 06:55:23 INFO - PID 1646 | Browser inner width/height: 1024/689 06:55:23 INFO - PID 1646 | __metrics 06:55:23 INFO - PID 1646 | 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" 06:55:23 INFO - PID 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:24 INFO - TEST-INFO | 1646: exit 0 06:55:24 INFO - Browser initialized. 06:55:24 INFO - Running cycle 1/1 for kraken test... 06:55:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpLwKvc5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:36 INFO - PID 1647 | RSS: Main: 233431040 06:55:36 INFO - PID 1647 | 06:55:39 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:40 INFO - PID 1647 | RSS: Main: 283959296 06:55:40 INFO - PID 1647 | 06:55:43 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 06:55:44 INFO - PID 1647 | RSS: Main: 285163520 06:55:44 INFO - PID 1647 | 06:55:47 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 06:55:48 INFO - PID 1647 | RSS: Main: 378400768 06:55:48 INFO - PID 1647 | 06:55:50 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 06:55:50 INFO - PID 1647 | RSS: Main: 279633920 06:55:50 INFO - PID 1647 | 06:55:52 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:53 INFO - PID 1647 | RSS: Main: 283279360 06:55:53 INFO - PID 1647 | 06:55:56 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:56 INFO - PID 1647 | RSS: Main: 323538944 06:55:56 INFO - PID 1647 | 06:55:59 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:00 INFO - PID 1647 | RSS: Main: 340586496 06:56:00 INFO - PID 1647 | 06:56:03 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 06:56:04 INFO - PID 1647 | RSS: Main: 351133696 06:56:04 INFO - PID 1647 | 06:56:05 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:06 INFO - PID 1647 | RSS: Main: 301232128 06:56:06 INFO - PID 1647 | 06:56:08 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:08 INFO - PID 1647 | RSS: Main: 305364992 06:56:08 INFO - PID 1647 | 06:56:10 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:11 INFO - PID 1647 | RSS: Main: 307445760 06:56:11 INFO - PID 1647 | 06:56:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:15 INFO - PID 1647 | RSS: Main: 325668864 06:56:15 INFO - PID 1647 | 06:56:18 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:18 INFO - PID 1647 | RSS: Main: 319619072 06:56:18 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 06:56:20 INFO - PID 1647 | RSS: Main: 380694528 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | __start_tp_report 06:56:20 INFO - PID 1647 | _x_x_mozilla_page_load 06:56:20 INFO - PID 1647 | _x_x_mozilla_page_load_details 06:56:20 INFO - PID 1647 | |i|pagename|runs| 06:56:20 INFO - PID 1647 | |0;ai-astar;116;116;116;116;117;124;168;154;116;123 06:56:20 INFO - PID 1647 | |1;audio-beat-detection;147;111;123;190;147;111;112;112;134;110 06:56:20 INFO - PID 1647 | |2;audio-dft;185;184;187;183;182;183;182;186;183;185 06:56:20 INFO - PID 1647 | |3;audio-fft;79;58;59;112;73;60;57;58;76;60 06:56:20 INFO - PID 1647 | |4;audio-oscillator;90;69;85;71;69;69;83;70;69;84 06:56:20 INFO - PID 1647 | |5;imaging-gaussian-blur;87;91;88;88;88;87;87;87;88;87 06:56:20 INFO - PID 1647 | |6;imaging-darkroom;96;94;96;95;95;103;94;94;94;94 06:56:20 INFO - PID 1647 | |7;imaging-desaturate;83;88;83;85;84;84;84;96;141;95 06:56:20 INFO - PID 1647 | |8;json-parse-financial;66;64;62;63;64;63;64;62;62;63 06:56:20 INFO - PID 1647 | |9;json-stringify-tinderbox;53;53;60;61;62;58;55;56;57;60 06:56:20 INFO - PID 1647 | |10;stanford-crypto-aes;84;82;81;80;82;82;83;81;80;79 06:56:20 INFO - PID 1647 | |11;stanford-crypto-ccm;139;140;138;142;136;141;138;138;193;162 06:56:20 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;181;188;181;186;182;184;184;186;180;220 06:56:20 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;66;67;67;67;68;67;67;67;67;68 06:56:20 INFO - PID 1647 | __end_tp_report 06:56:20 INFO - PID 1647 | __start_cc_report 06:56:20 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2178 06:56:20 INFO - PID 1647 | __end_cc_report 06:56:20 INFO - PID 1647 | __startTimestamp1489586180920__endTimestamp 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | ------- Summary: start ------- 06:56:20 INFO - PID 1647 | Number of tests: 14 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:126.60 Median:120.00 stddev:18.67 (15.6%) stddev-sans-first:19.41 06:56:20 INFO - PID 1647 | Values: 116.0 116.0 116.0 116.0 117.0 124.0 168.0 154.0 116.0 123.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:128.50 stddev:25.85 (20.1%) stddev-sans-first:26.64 06:56:20 INFO - PID 1647 | Values: 147.0 111.0 123.0 190.0 147.0 111.0 112.0 112.0 134.0 110.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.70 (0.9%) stddev-sans-first:1.76 06:56:20 INFO - PID 1647 | Values: 185.0 184.0 187.0 183.0 182.0 183.0 182.0 186.0 183.0 185.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:69.20 Median:60.00 stddev:17.20 (28.7%) stddev-sans-first:17.87 06:56:20 INFO - PID 1647 | Values: 79.0 58.0 59.0 112.0 73.0 60.0 57.0 58.0 76.0 60.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:77.00 stddev:8.48 (11.0%) stddev-sans-first:7.30 06:56:20 INFO - PID 1647 | Values: 90.0 69.0 85.0 71.0 69.0 69.0 83.0 70.0 69.0 84.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 06:56:20 INFO - PID 1647 | Values: 87.0 91.0 88.0 88.0 88.0 87.0 87.0 87.0 88.0 87.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:94.50 stddev:2.76 (2.9%) stddev-sans-first:2.92 06:56:20 INFO - PID 1647 | Values: 96.0 94.0 96.0 95.0 95.0 103.0 94.0 94.0 94.0 94.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:84.50 stddev:17.78 (21.0%) stddev-sans-first:18.53 06:56:20 INFO - PID 1647 | Values: 83.0 88.0 83.0 85.0 84.0 84.0 84.0 96.0 141.0 95.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:0.87 06:56:20 INFO - PID 1647 | Values: 66.0 64.0 62.0 63.0 64.0 63.0 64.0 62.0 62.0 63.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:59.00 stddev:3.24 (5.5%) stddev-sans-first:3.00 06:56:20 INFO - PID 1647 | Values: 53.0 53.0 60.0 61.0 62.0 58.0 55.0 56.0 57.0 60.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:1.51 (1.8%) stddev-sans-first:1.27 06:56:20 INFO - PID 1647 | Values: 84.0 82.0 81.0 80.0 82.0 82.0 83.0 81.0 80.0 79.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:140.50 stddev:17.88 (12.7%) stddev-sans-first:18.75 06:56:20 INFO - PID 1647 | Values: 139.0 140.0 138.0 142.0 136.0 141.0 138.0 138.0 193.0 162.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:185.00 stddev:11.81 (6.4%) stddev-sans-first:12.31 06:56:20 INFO - PID 1647 | Values: 181.0 188.0 181.0 186.0 182.0 184.0 184.0 186.0 180.0 220.0 06:56:20 INFO - PID 1647 | 06:56:20 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 06:56:20 INFO - PID 1647 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 06:56:20 INFO - PID 1647 | -------- Summary: end -------- 06:56:20 INFO - PID 1647 | 06:56:21 INFO - TEST-INFO | 1647: exit 0 06:56:21 INFO - TEST-OK | kraken | took 60929ms 06:56:21 INFO - SUITE-END | took 1180s 06:56:22 INFO - Completed test suite (00:19:41) 06:56:22 INFO - javascript benchmark 06:56:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7749.908065208339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2869.6126022986896, 3071.2168397058745, 3358.194033431976, 3367.4780409036593, 3378.510116033177, 4627.768611569425, 5678.091505359143, 5742.712864356781, 5784.68184249866, 5810.389909059546, 5688.288963879515, 5759.856003599912, 5760.0, 5762.769489220426, 5811.4479124483105, 4746.579320720225, 5119.795208191668, 5144.7170405627585, 5200.713960732158, 5205.427402985669, 5314.681119132845, 5345.7594408251525, 5348.251244825728, 5362.65142765719, 5367.75845086972, 5154.201098829687, 5185.818496352647, 5188.092083885343, 5229.660072095302, 5298.708571028592, 5244.029854476896, 5245.606579506514, 5254.448282930313, 5313.38896026958, 5325.8934821303355, 5128.076946149691, 5206.635535512516, 5209.869753256199, 5236.162214045772, 5255.0540902637895, 5585.2459917910965, 5629.9437005629825, 5707.74315155819, 5714.371419143891, 5737.2254745609225, 4996.4254110777365, 6188.195534580521, 6252.87494250117, 6300.086487459339, 6325.051242313643, 6222.533310001722, 6265.248170219603, 6288.528360372945, 6291.213598300213, 6306.684665766693, 5778.959787238337, 5858.12128180772, 5869.0, 5870.354261031283, 5891.293044834647, 6236.314005459396, 6249.6562689052535, 6258.906116408258, 6287.685615719287, 6290.150829638032, 6183.227096612924, 6213.502919766408, 6226.533010024266, 6229.345918678564, 6232.594881332699, 6294.150289710922, 6296.905546416808, 6303.747850086037, 6331.0, 6337.683115844189, 6125.173101631222, 6132.539076726543, 6133.407859146218, 6207.441330280206, 6299.811005669837, 6263.0, 6302.464290535356, 6306.337834527309, 6309.400606942333, 6316.9368306317265, 4890.535399137077, 5010.498950105033, 5027.245913112989, 5036.320096786887, 5071.923921141186, 4438.201123797748, 4446.9777651111535, 4462.464504259445, 4491.281394976788, 4501.549845015472, 5761.452661997104, 5768.394318596571, 5771.394003629643, 5782.624129431573, 5785.27684039495, 6162.168107305546, 6238.220222472191, 6244.250689917239, 6249.187605611241, 6250.406211409909, 5765.279340082489, 5774.595778295479, 5778.3643799182055, 5790.334111577223, 5791.247137872049, 5429.945700543023, 5466.180072989004, 5479.4520547944885, 5490.423505531941, 5492.0, 6304.432601065926, 6311.147995020613, 6316.684165791692, 6331.683415829098, 6335.746570137143, 6246.031865060922, 6281.4660753834605, 6293.559450838397, 6302.716377763103, 6322.272938612118, 6376.776812811529, 6395.6482393468805, 6406.231252249573, 6418.518611104092, 6427.3251308611925, 6127.3566275540425, 6266.592671476339, 6277.15258440123, 6283.183186185949, 6292.276388215414, 6203.4416902479, 6244.0, 6249.78125765596, 6263.592866463665, 6305.4009869062365, 5216.869578260574, 5608.831735047955, 6095.634261944298, 6125.540584456273, 6135.967692822179, 5993.580449368676, 6111.1444397785235, 6127.816165515042, 6155.446009859134, 6166.722497487534, 5789.92886316016, 5847.035239185657, 5856.472917437451, 6008.849778755566, 6013.609115407485, 6113.415495409368, 6167.414095660905, 6204.7828326008375, 6212.409821066992, 6227.314995350598, 5985.132155837467, 6003.8198854034445, 6007.0, 6007.158997740233, 6063.242094738158], "value": 5712.644640905926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.9884651730223, 851.2551517422255, 864.5547543015348, 869.1873098652765, 872.1670804381816, 37887.81056094719, 38649.22701545968, 38661.84014479563, 38701.80649096754, 38708.419373709345, 37001.0, 37302.47206738817, 37403.0, 37517.24965500695, 37575.81212093942, 7348.301911318416, 7522.172561018284, 7732.922670773277, 7905.090914544843, 7930.682772689085, 10638.255322127454, 10827.83758243627, 11076.944615276952, 11089.27919685222, 11093.667189984313, 9977.800443991116, 11211.383373914432, 11270.211085224038, 11278.436078196099, 11302.208845380826, 7311.378532824663, 7486.700531978714, 11196.328220306767, 11227.326360418401, 11235.325880447199, 9170.312226582966, 10671.03960643538, 10865.45672716361, 10894.237403381767, 10908.400037997906, 38249.0, 38569.0, 38667.613323866964, 38673.613263867286, 38735.61264387348, 3226.9677303226904, 3821.5605205401457, 3854.286956912952, 3873.9806300968316, 3973.7417067890783, 28081.719182808116, 28571.85714071437, 29195.85402072976, 29221.41557168845, 29341.413171736447, 3063.6476805167467, 3210.2776875202894, 3223.403670320998, 3235.223546348883, 3240.141362538929, 251593.0, 253448.0, 311696.99999999773, 312909.30636040476, 313582.0, 40300.99247518777, 40817.387739183934, 40817.979550511474, 48374.75812620914, 52285.47714522882, 52508.73745631324, 52943.47056529386, 52949.47050529523, 53123.20315195275, 53223.467765322624, 14681.650935850426, 14802.407903683947, 14833.480828170963, 14850.925745371203, 14896.255187240595, 11899.107566932515, 11951.92432681063, 11989.820152697717, 11996.64010079699, 12004.0, 13929.86070139306, 14050.297485125702, 14079.718405632035, 14122.03437278183, 14191.78712319316, 5837.9124313135335, 5873.970630146822, 5920.082387229986, 5928.199693041471, 5937.940620593825, 1123.292325834719, 1132.2923173016864, 1132.5186795611833, 1148.035650053942, 1177.587844254521, 24791.5041699165, 27153.0, 27309.590356144672, 27471.725282747317, 27590.862045690046, 1220.17638094286, 1233.2292317301687, 1255.4162314523608, 1277.6933535951305, 1286.395394164741, 13383.933080334536, 13872.375743091585, 14205.147691138565, 14207.573772786833, 14250.0, 456437.0, 459297.0, 461329.0, 462005.0, 462344.0, 57597.712011439675, 57967.0, 58010.70994645, 58053.4194658048, 58066.0, 1355.2749279135614, 1436.4469679173385, 1436.5762100180682, 1441.5531185332582, 1458.6936743283818, 24351.26946191617, 25096.498070038862, 25362.873185634693, 26737.732622673524, 26788.0, 47812.760936195096, 47846.043079137526, 47886.28170577514, 47910.76044619754, 48110.0, 406351.0, 406386.0, 407157.0695809526, 407962.0, 408530.0, 25981.610275845498, 31455.842720786248, 33244.833775830964, 33295.0, 35238.11904702403, 40656.59343406528, 40970.1805963885, 42118.73643790691, 42144.78927605342, 42236.577634223264, 33709.83145084259, 33829.154271143416, 33901.98294051182, 34967.30065398729, 35277.0, 33725.49411758874, 33778.15554611154, 34792.652073478945, 35057.474137888465, 36186.45720314145, 35624.46563301501, 36286.092847677966, 36323.0, 36370.4544431839, 36392.0, 22479.88760056189, 28609.570856436752, 30159.944401945828, 31557.36885262328, 31629.051128466184, 23290.76709232886, 23918.9316793646, 24062.759372406752, 24224.78876056155, 24270.0], "value": 18711.071052743147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.3148983747954, 398.32086292870656, 416.8645190313148, 420.32537776868134, 422.9725067870588, 20137.899310503446, 20769.480762980915, 21020.0, 21249.893750531224, 21463.67804482932, 20829.0, 20874.37376878692, 21083.68374474384, 21404.678929816026, 21675.566488670218, 6530.412262896339, 6887.827804304908, 6889.4832887533385, 6901.0, 6904.792856214296, 6023.337432882401, 6497.805065848009, 6564.916788729878, 6714.764983225588, 6728.461723062143, 6695.962125870498, 6786.355296246848, 6788.592684438925, 6789.287124851893, 6800.285969973156, 6628.536002479805, 6732.730690772363, 6780.355866192728, 6784.8303792405095, 6794.116764820591, 6588.505862060317, 6620.536562440631, 7291.234420385889, 7580.658870350848, 7622.627926973142, 25963.610545841828, 27857.72142278592, 28061.85969070162, 28117.156485305473, 28349.858250708614, 2772.5702516110036, 2879.1074766822353, 2900.3329234276025, 2900.5939168516425, 2900.76793856491, 15024.924875375662, 15506.5348039559, 15917.52247432579, 16476.588085297964, 16713.49859504217, 1990.99004504978, 2036.4603380104284, 2059.6086743518686, 2063.3912995666315, 2085.374387683704, 80391.99999999942, 92012.53993729988, 101290.0, 110065.0, 154863.0, 17239.56901077458, 19849.801501985083, 20413.69379459309, 21949.122035118417, 22257.888710556344, 37205.0, 37253.81373093172, 37368.81315593405, 37454.0, 37456.62543374586, 8466.957665211634, 8586.484810911365, 9942.900570994198, 10207.438590877424, 10493.632722854816, 8265.421420500506, 8284.627191776384, 8294.958525207456, 8434.704785332484, 8475.660973561111, 8389.706360277361, 9516.667666526691, 9998.850017249748, 10588.364698118137, 10644.0, 3765.8325918965206, 3963.92072158561, 4105.137921036616, 4175.853845115406, 4187.497500299984, 833.5248908122312, 971.8833739951251, 1008.6233828057902, 1012.9290949633455, 1023.4831410137833, 21935.232266870582, 22614.547709045728, 22666.979985900674, 22672.0, 22719.318420447413, 839.9538025408661, 981.9459929703935, 990.6483198464585, 1008.7730260691286, 1017.1100287248657, 9360.630173137664, 10513.317869140901, 11478.288633461154, 11635.243709158878, 11676.70808229784, 651152.0, 651187.0, 688202.0, 706197.9731722758, 710826.0, 99236.50381748189, 116363.0, 151398.0, 153798.2310088465, 158451.20774396285, 1218.622227109599, 1222.6698791326291, 1251.3180316727223, 1263.2294300476701, 1276.1003492537739, 15228.695426091195, 18008.909955450665, 18572.628547429245, 21523.461913452287, 21581.813000285136, 49646.0, 59803.70098149481, 61385.386146137964, 62195.68902155641, 62557.0, 83686.58156709178, 85311.0, 86165.56917215374, 86211.70682439643, 86991.13008869831, 9880.901190987997, 11109.388983605655, 11688.94155529217, 11872.881271187178, 11893.21601759743, 12734.426950787052, 12940.741185176432, 13038.348082596021, 13197.670058248237, 13409.731805364034, 10983.83524247121, 11029.117670586495, 11111.666650000512, 11215.775684486427, 11244.775104498029, 11104.111671066134, 11175.608853690406, 11417.60038398652, 11444.656660300205, 11565.595204167814, 10973.0, 11171.21801473889, 11451.08391328675, 11568.826467603161, 11618.360990145624, 11300.756916739316, 11303.660890173307, 11708.238964467282, 11720.589779357682, 11746.647600571996, 11123.443827808738, 11158.274712143684, 11322.773544528898, 11326.943365283121, 11404.771904562029], "value": 11436.3392125552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.2078856628852, 1557.3692654474942, 1566.1934103936467, 1598.432556442463, 1603.118284943281, 10471.895281047187, 10961.0, 10962.28745131567, 10962.506687199075, 10981.615643452471, 10412.843807342895, 10778.784424311509, 10784.97542733441, 10816.945915270413, 10850.620228292011, 2289.9656505152393, 2332.4285550040263, 2335.0, 2335.3577766114367, 2335.754745751697, 2273.897674604647, 2318.6637937499054, 2318.7217533895955, 2321.8374713770045, 2327.813774898004, 1876.7278744582095, 2215.3464727905307, 2234.7988681018705, 2237.2505210754334, 2244.36035729817, 2257.683924250606, 2284.3946354216146, 2284.931452056441, 2285.6228722260807, 2285.622872226089, 1847.7320788485729, 2301.9526115617355, 2304.9308520744403, 2314.6528020796845, 2320.1763374002326, 10848.349099054081, 10925.125989920787, 10930.070943969773, 10944.671659850217, 10944.890551094546, 4775.2359622460235, 5783.913241301384, 5787.768489260425, 5797.246357973479, 5821.7380217890295, 3089.891853785129, 3245.334706385185, 3579.2483578448555, 3593.9101522461888, 3600.5499312585926, 1123.3147779854364, 1128.751674631588, 1185.3302883870585, 1185.4453652379136, 1194.994025029878, 15288.388464461408, 15390.615234619112, 15455.304511296907, 15472.839537034655, 15507.844921550753, 4344.847930322424, 4559.6808223424705, 4601.792919318638, 4693.460252070987, 4697.577218050392, 11240.381779002233, 11241.55033798639, 11253.043491303331, 11253.268537545033, 11265.324080555192, 5655.981923253854, 5665.461781130786, 5668.26312579362, 5679.403662615366, 5696.8006119785605, 4996.375453068366, 5036.546710796046, 5139.897202055938, 5195.142801437721, 5285.497877701612, 3670.284294562535, 3756.8309426075343, 3775.244951009754, 3816.5497111097607, 3835.884923452301, 1009.7627057641448, 1012.1649639047815, 1024.8052869954686, 1025.6820385680314, 1027.0038063078803, 892.8705337725993, 918.4672889723944, 927.1423932862076, 935.5654199096235, 974.1281553010016, 6409.284131957615, 6410.967945160244, 6653.2681405045405, 6722.764703235363, 6806.659667016629, 923.8660394242797, 940.5955439161089, 959.2469911119738, 959.5490119643756, 977.5744617373548, 3840.0, 3879.80600969956, 3969.2458432897656, 3998.260321840469, 4003.479547658844, 13235.94112471, 13332.73334533304, 13737.931310343385, 13740.65648358799, 13743.656408589864, 11842.822357664641, 13335.93332033353, 13582.388792504362, 13617.455301788015, 13627.0, 7960.681572737141, 8198.795030124294, 8722.386358523567, 9911.900880991097, 9935.602575896883, 6499.350064993463, 6588.341165883373, 6704.932950670431, 6754.358335958076, 6781.11845460087, 11592.0, 12132.454039568063, 12147.81778273309, 12154.878451215729, 12159.878401215874, 10512.632057877938, 11921.34432606215, 12282.570110046105, 12399.75200496003, 12447.377631118588, 8175.119722463748, 8367.079621241537, 8493.787655308419, 8625.180607842245, 8627.827443451222, 9458.95270523643, 9636.807263854824, 9651.565679544297, 9681.806363872824, 9706.417614942844, 8364.0, 8400.49597024156, 8420.326373889951, 8469.237768600855, 8621.361941231145, 8261.917380826115, 8302.626381812712, 8312.958435207785, 8359.122292159478, 8367.288780453486, 7265.382442492447, 7414.406847452299, 7422.628868556659, 7426.554406735613, 7432.777016689508, 5443.183522471661, 5526.861828454321, 5594.664320140641, 5636.210930469655, 5675.432456754292, 5504.366997795145, 5652.3217213934595, 5665.263515742927, 5714.885702286014, 5761.654300741969], "value": 4959.612374663881, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.5912732503546, 386.42615715662254, 387.98836034918946, 391.85893078491756, 398.31489837479523, 5691.601587888849, 5714.914276285859, 5761.4814666679995, 5765.625234359774, 5806.274215723035, 4400.691951563392, 5517.668939863611, 5662.37713851476, 5668.886622267562, 5700.116481945305, 4394.780260986954, 4402.295632698769, 4422.5577442255835, 4434.401355816972, 4442.777861106948, 3967.246223217594, 4099.528554216258, 4413.58070983256, 4421.425214722081, 4461.598456138947, 3621.8370173342264, 3936.6260205280596, 4284.614384705376, 4413.7558894212725, 4418.712783669067, 3598.352296586613, 4379.8467053653285, 4392.692511524195, 4399.318105693623, 4423.248047831877, 3906.257811015926, 3910.296146693594, 3923.3330333843314, 3925.3523168677134, 3927.998360418104, 5378.946210537883, 5541.778328866841, 5554.805986557745, 5579.0, 5594.356648985378, 4224.197402493516, 4543.681942264043, 5143.71709555978, 5203.427622961472, 5227.921581176285, 6162.8767424651705, 6165.841955315604, 6171.722272497748, 6173.351798061184, 6184.96907515464, 3394.915127121817, 4166.0834616384345, 4368.716033457847, 4395.208862404766, 4404.933925991113, 6216.751329946796, 6389.744410223586, 6426.2931077581425, 6432.710528026157, 6462.838429039265, 4778.163821331323, 4785.947091639834, 5250.553702935294, 5277.656952298088, 5308.124159513714, 4515.367848501212, 4804.231322988305, 4832.903341933142, 5221.921671174935, 5456.345238571397, 5718.771249149988, 5723.713814309268, 5752.511036561856, 5768.0, 5776.624519406309, 5999.700014999233, 6214.161088253119, 6224.190855188887, 6227.470664993436, 6288.213973253343, 1878.1736036144052, 1928.4793105861338, 1928.4889504281377, 1933.7679478462674, 1936.951576210606, 1330.9134906231063, 1402.214759734552, 1459.737247295497, 1524.3216768537893, 1569.6154442161744, 5612.410696876851, 5855.970720146372, 5867.513874527245, 5880.852978675567, 5884.086787532458, 5231.738413079331, 6372.406898275432, 6393.552451328455, 6407.935920640734, 6459.418652321314, 4902.754862256944, 5574.331080270394, 5811.970940145272, 5823.912641310384, 5920.4967577755515, 2771.362586605092, 2795.916122516328, 3303.487959366302, 3307.6030876295, 3329.5183643278992, 5569.777208911679, 6342.0, 6469.417752402306, 6630.701618427182, 6693.661267746373, 6489.253735820346, 6521.836954076091, 6543.967280163664, 6560.0, 6584.5061620378665, 6104.901117798839, 6346.333634968447, 6644.0, 6660.73534998103, 6665.667615765043, 5454.10007348783, 6059.242594675666, 6306.306306306211, 6333.606606546552, 6361.491080713439, 5974.416779553509, 6189.907151392823, 6297.590656607306, 6316.7157477914525, 6319.8104056878365, 6189.6286222826775, 6624.436922861611, 6636.469082473487, 6660.602183214136, 6762.391384775394, 4357.714474230173, 4884.9511504884495, 4994.600431965507, 5032.672876263031, 5043.798248070036, 6204.689765511796, 6405.263394709668, 6483.351664833479, 6494.265797166554, 6500.837479063061, 5972.25346831646, 6158.353372895782, 6230.968845155927, 6237.282712488122, 6260.68696565179, 4586.747728874944, 5714.5999780015, 5814.215080964016, 6230.0, 6238.500919926304, 5879.73541190656, 6077.361877002851, 6097.695115244309, 6127.571070025234, 6193.071039344134, 6232.657203853832, 6237.28271248794, 6239.625622462667, 6239.656818875005, 6242.188515492957, 5068.315777370008, 5555.583331250092, 5798.796457346181, 6103.694815259308, 6120.479759220338], "value": 4713.640174202085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.9571025738453, 719.1011235955057, 728.582906247349, 767.9785884773252, 834.3908946469078, 14947.775783363244, 15678.686426271468, 15705.371785128595, 15711.607209819746, 17583.73624395635, 16531.91734041331, 17040.403585874497, 17153.05658188799, 17335.0, 17342.653146937053, 952.2477242978039, 978.9902100979006, 984.2027957354566, 985.5072463768116, 986.1371300112402, 960.2462067277189, 982.1651596143292, 986.2307400227797, 988.3229987458614, 992.5087081894472, 1047.282611411182, 1047.481496659151, 1048.6487026846016, 1048.7273308939693, 1050.4747626186906, 1037.584966013593, 1040.588967357897, 1042.2027149230844, 1044.0186224948525, 1047.1675018360384, 768.8846672999039, 770.3606007014165, 771.8533478639097, 772.996135019327, 781.3709963479397, 15266.007709498957, 15611.063336199864, 15731.134787586678, 15999.360025598962, 16164.838351616569, 14277.14337139775, 14560.344784484723, 14726.116433014053, 14726.70546589073, 14756.262186890719, 11676.532938682443, 11767.352795596238, 11851.881481185164, 11946.402679865972, 11986.400679966055, 3657.762245454037, 3716.650056771144, 3814.370628846237, 3896.1428485733377, 3898.3567711327596, 109425.0, 110826.0, 111616.0, 112075.0, 112810.43594781973, 10700.892991070144, 11373.431328433546, 11503.367314797599, 11629.88370116305, 12091.214071085351, 20728.378148655564, 24524.632130518057, 25122.623160652605, 25124.371890702878, 25326.74673253244, 7857.567833769198, 7937.2459616336355, 7951.244631759973, 8015.759527214076, 8196.959015204886, 4266.679999000087, 4271.124419493996, 4311.547287534827, 4334.371516130143, 4352.912941741148, 3495.265994141208, 3542.096765324826, 3551.857925682944, 3552.609212986569, 3564.6791788739138, 581.8545363659085, 582.3594046548762, 583.1451290085023, 586.3286536915208, 589.6491587505427, 635.853753636657, 661.798151563768, 688.7017971124467, 705.1679018757812, 722.6784081083972, 9548.952255238679, 9850.50747462624, 9948.950255248823, 10073.41472864366, 10262.230332725076, 651.5596211816455, 693.3136195166749, 712.1311999360771, 722.9421646268286, 727.1710250314645, 3706.4440333950124, 4250.808713607895, 4361.542038085955, 4630.907381852344, 4857.0, 73677.0, 76068.23931760722, 96733.5163324193, 97484.0251597475, 102215.48892255491, 61766.0, 78848.60575697085, 81109.18890811135, 81643.5917820407, 82794.75807862887, 52919.94160116776, 74985.0, 75423.99999999891, 76506.61746691231, 77073.0, 9129.45223286605, 9225.07749225072, 9292.95353523228, 9312.161905428544, 9420.811583768424, 40925.795371022956, 42879.571204288804, 47311.0, 47472.0, 48959.51040489692, 61222.08166877589, 61440.0, 62247.688761557714, 63016.68491657513, 64414.677926610064, 13326.666833328856, 13338.733225335633, 13491.25798081115, 14070.226137562533, 14164.308761479275, 14230.501932432315, 14577.198254095701, 14589.197594132425, 14619.85380146185, 14665.266736663338, 13410.664733381744, 13503.0, 13645.931770341085, 13754.793678094637, 14154.0, 12890.806637900252, 13076.803847942097, 13309.134906231064, 13345.199288042748, 14089.084209526758, 13093.672658183621, 13258.53595124166, 13300.800487992881, 13559.45762169502, 13597.728045438838, 9328.720138395858, 9957.601695932082, 9957.950210248902, 10214.540345684314, 10672.466376680979, 8552.014527748388, 8827.779305517413, 9769.56036978352, 9781.217502599917, 9847.162991145833], "value": 7580.7870729902, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 124.0, 168.0, 154.0, 116.0, 123.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 123.0, 190.0, 147.0, 111.0, 112.0, 112.0, 134.0, 110.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 183.0, 182.0, 183.0, 182.0, 186.0, 183.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 112.0, 73.0, 60.0, 57.0, 58.0, 76.0, 60.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 71.0, 69.0, 69.0, 83.0, 70.0, 69.0, 84.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 88.0, 88.0, 88.0, 87.0, 87.0, 87.0, 88.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 96.0, 95.0, 95.0, 103.0, 94.0, 94.0, 94.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 83.0, 85.0, 84.0, 84.0, 84.0, 96.0, 141.0, 95.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 62.0, 63.0, 64.0, 63.0, 64.0, 62.0, 62.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 60.0, 61.0, 62.0, 58.0, 55.0, 56.0, 57.0, 60.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 80.0, 82.0, 82.0, 83.0, 81.0, 80.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 138.0, 142.0, 136.0, 141.0, 138.0, 138.0, 193.0, 162.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 188.0, 181.0, 186.0, 182.0, 184.0, 184.0, 186.0, 180.0, 220.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.1, "unit": "score"}]}]} 06:56:22 INFO - Return code: 0 06:56:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:56:22 ERROR - # TBPL SUCCESS # 06:56:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:22 INFO - 2017-03-15 06:56:22.242 screenresolution[1651:9680] starting screenresolution argv=screenresolution get 06:56:22 INFO - 2017-03-15 06:56:22.244 screenresolution[1651:9680] Display 0: 1600x1200x32@60 06:56:22 INFO - 2017-03-15 06:56:22.250 screenresolution[1652:9683] starting screenresolution argv=screenresolution list 06:56:22 INFO - Available Modes on Display 0 06:56:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:22 INFO - Intel Iris: 06:56:22 INFO - Chipset Model: Intel Iris 06:56:22 INFO - Type: GPU 06:56:22 INFO - Bus: Built-In 06:56:22 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:22 INFO - Vendor: Intel (0x8086) 06:56:22 INFO - Device ID: 0x0a2e 06:56:22 INFO - Revision ID: 0x0009 06:56:22 INFO - Displays: 06:56:22 INFO - Display: 06:56:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:22 INFO - Display Serial Number: 1600x1200 60 06:56:22 INFO - Main Display: Yes 06:56:22 INFO - Mirror: Off 06:56:22 INFO - Online: Yes 06:56:22 INFO - Rotation: Supported 06:56:22 INFO - Return code: 0 06:56:22 INFO - Running post-action listener: _resource_record_post_action 06:56:22 INFO - [mozharness: 2017-03-15 13:56:22.488600Z] Finished run-tests step (success) 06:56:22 INFO - Running post-run listener: _resource_record_post_run 06:56:22 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 39715840; Write bytes: 513580544; Read time: 392; Write time: 1728 06:56:22 INFO - TinderboxPrint: CPU usage
53.3% 06:56:22 INFO - TinderboxPrint: I/O read bytes / time
39,715,840 / 392 06:56:22 INFO - TinderboxPrint: I/O write bytes / time
513,580,544 / 1,728 06:56:22 INFO - TinderboxPrint: CPU idle
2,245.5 (46.7%) 06:56:22 INFO - TinderboxPrint: CPU system
955.8 (19.9%) 06:56:22 INFO - TinderboxPrint: CPU user
1,608.3 (33.4%) 06:56:22 INFO - TinderboxPrint: Swap in / out
248,745,984 / 0 06:56:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205928960; Write bytes: 204199424; Read time: 15802; Write time: 478 06:56:22 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 37655552; Write bytes: 298567680; Read time: 368; Write time: 1215 06:56:22 INFO - Running post-run listener: _upload_blobber_files 06:56:22 INFO - Blob upload gear active. 06:56:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:22 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 06:56:22 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'] 06:56:22 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 06:56:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:24 INFO - (blobuploader) - INFO - Done attempting. 06:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:56:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:25 INFO - (blobuploader) - INFO - Done attempting. 06:56:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:56:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:26 INFO - (blobuploader) - INFO - Done attempting. 06:56:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:28 INFO - (blobuploader) - INFO - Done attempting. 06:56:28 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:28 INFO - Return code: 0 06:56:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d113608fd1f817a6bd854f3d3a1dc66a29ccfe4f9e15b910e246ebde28457c43b1df32d73edd0c5ad1c61a423a94a7c1703d55f97709a7b5173cda2be7627ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f283ec7a3da07d0eeb49142b944b61c6502702d9e60bf49e941975c28920809983df974de1a06760c2a03c8059ad9ff115bbc60288b3908719b2a279ea9bb85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee376f3bd5b082afafa59fbc26e270643b832fdd51b38f974994146fea57e24b5e704053cd54db66128a5f868e20ae270abe3af270ec8b1ec83f67c833ab146", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e56c96d5412f6ca740d0f6d1b3076132004f38f9a6fe2db3f4920348f89d108a40503ef818ab82dfdb887906c4b2ab6339285168aa571da217f989f9f6c5043"} 06:56:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:28 INFO - Contents: 06:56:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d113608fd1f817a6bd854f3d3a1dc66a29ccfe4f9e15b910e246ebde28457c43b1df32d73edd0c5ad1c61a423a94a7c1703d55f97709a7b5173cda2be7627ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f283ec7a3da07d0eeb49142b944b61c6502702d9e60bf49e941975c28920809983df974de1a06760c2a03c8059ad9ff115bbc60288b3908719b2a279ea9bb85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee376f3bd5b082afafa59fbc26e270643b832fdd51b38f974994146fea57e24b5e704053cd54db66128a5f868e20ae270abe3af270ec8b1ec83f67c833ab146", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e56c96d5412f6ca740d0f6d1b3076132004f38f9a6fe2db3f4920348f89d108a40503ef818ab82dfdb887906c4b2ab6339285168aa571da217f989f9f6c5043"} 06:56:28 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:28 INFO - Copying logs to upload dir... 06:56:28 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.566451 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-15 06:56:28.795556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 06:56:28.799339) ========= 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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/7d113608fd1f817a6bd854f3d3a1dc66a29ccfe4f9e15b910e246ebde28457c43b1df32d73edd0c5ad1c61a423a94a7c1703d55f97709a7b5173cda2be7627ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f283ec7a3da07d0eeb49142b944b61c6502702d9e60bf49e941975c28920809983df974de1a06760c2a03c8059ad9ff115bbc60288b3908719b2a279ea9bb85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee376f3bd5b082afafa59fbc26e270643b832fdd51b38f974994146fea57e24b5e704053cd54db66128a5f868e20ae270abe3af270ec8b1ec83f67c833ab146", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e56c96d5412f6ca740d0f6d1b3076132004f38f9a6fe2db3f4920348f89d108a40503ef818ab82dfdb887906c4b2ab6339285168aa571da217f989f9f6c5043"} build_url:https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010960 build_url: 'https://queue.taskcluster.net/v1/task/A9Ww0MgsSIa07CMivepc-A/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/7d113608fd1f817a6bd854f3d3a1dc66a29ccfe4f9e15b910e246ebde28457c43b1df32d73edd0c5ad1c61a423a94a7c1703d55f97709a7b5173cda2be7627ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f283ec7a3da07d0eeb49142b944b61c6502702d9e60bf49e941975c28920809983df974de1a06760c2a03c8059ad9ff115bbc60288b3908719b2a279ea9bb85", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee376f3bd5b082afafa59fbc26e270643b832fdd51b38f974994146fea57e24b5e704053cd54db66128a5f868e20ae270abe3af270ec8b1ec83f67c833ab146", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e56c96d5412f6ca740d0f6d1b3076132004f38f9a6fe2db3f4920348f89d108a40503ef818ab82dfdb887906c4b2ab6339285168aa571da217f989f9f6c5043"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 06:56:28.833629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:56:28.833967) ========= 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.tPLvzI3VAp/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.CLOihtTB9Z/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 06:56:28.882855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 06:56:28.883218) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 06:56:28.883552) ========= ========= Total master_lag: 0.22 =========