builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0069 starttime: 1489510352.63 results: success (0) buildid: 20170314081436 builduid: bbf87303c1b446fc8f5175dcad47978e revision: 2baef2ffbaedb7354286726660ebd36e84b432f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.630406) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.630892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.631234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.658453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.658900) ========= 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.tPXkZrz2hL/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.jysL54Y6iy/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-14 09:52:32-- 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% 166M=0s 2017-03-14 09:52:32 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.811676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.812106) ========= 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.tPXkZrz2hL/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.jysL54Y6iy/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.029944 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:32.863465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-14 09:52:32.863840) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2baef2ffbaedb7354286726660ebd36e84b432f0 --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 2baef2ffbaedb7354286726660ebd36e84b432f0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tPXkZrz2hL/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.jysL54Y6iy/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-14 09:52:32,980 truncating revision to first 12 chars 2017-03-14 09:52:32,981 Setting DEBUG logging. 2017-03-14 09:52:32,981 attempt 1/10 2017-03-14 09:52:32,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2baef2ffbaed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 09:52:34,692 unpacking tar archive at: mozilla-central-2baef2ffbaed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.981949 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-14 09:52:34.912126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:34.912430) ========= script_repo_revision: 2baef2ffbaedb7354286726660ebd36e84b432f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:34.912858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:34.913185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 09:52:34.933559) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-14 09:52:34.933879) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.tPXkZrz2hL/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.jysL54Y6iy/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:52:35 INFO - MultiFileLogger online at 20170314 09:52:35 in /builds/slave/test 09:52:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:52:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:35 INFO - {'append_to_log': False, 09:52:35 INFO - 'base_work_dir': '/builds/slave/test', 09:52:35 INFO - 'blob_upload_branch': 'Firefox', 09:52:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:35 INFO - 'branch': 'Firefox', 09:52:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:35 INFO - 'config_files': ('talos/mac_config.py',), 09:52:35 INFO - 'default_actions': ('clobber', 09:52:35 INFO - 'read-buildbot-config', 09:52:35 INFO - 'download-and-extract', 09:52:35 INFO - 'populate-webroot', 09:52:35 INFO - 'create-virtualenv', 09:52:35 INFO - 'install', 09:52:35 INFO - 'run-tests'), 09:52:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:35 INFO - 'download_minidump_stackwalk': True, 09:52:35 INFO - 'download_symbols': 'ondemand', 09:52:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:35 INFO - 'gecko_profile': False, 09:52:35 INFO - 'gecko_profile_interval': 0, 09:52:35 INFO - 'installer_path': 'installer.exe', 09:52:35 INFO - 'log_level': 'info', 09:52:35 INFO - 'log_name': 'talos', 09:52:35 INFO - 'log_to_console': True, 09:52:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:52:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:52:35 INFO - 'opt_config_files': (), 09:52:35 INFO - 'pip_index': False, 09:52:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:52:35 INFO - 'cmd': ('bash', 09:52:35 INFO - '-c', 09:52:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:52:35 INFO - 'enabled': True, 09:52:35 INFO - 'halt_on_failure': False, 09:52:35 INFO - 'name': 'check_screen_resolution'},), 09:52:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:52:35 INFO - 'cmd': ('bash', 09:52:35 INFO - '-c', 09:52:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:52:35 INFO - 'enabled': True, 09:52:35 INFO - 'halt_on_failure': False, 09:52:35 INFO - 'name': 'check_screen_resolution'},), 09:52:35 INFO - 'run_cmd_checks_enabled': True, 09:52:35 INFO - 'suite': 'dromaeojs-e10s', 09:52:35 INFO - 'system_bits': '32', 09:52:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:35 INFO - 'title': 't-yosemite-r7-0069', 09:52:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:35 INFO - 'use_talos_json': True, 09:52:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:35 INFO - 'work_dir': 'build'} 09:52:35 INFO - [mozharness: 2017-03-14 16:52:35.164171Z] Running clobber step. 09:52:35 INFO - Running pre-action listener: _resource_record_pre_action 09:52:35 INFO - Running main action method: clobber 09:52:35 INFO - rmtree: /builds/slave/test/build 09:52:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:37 INFO - Running post-action listener: _resource_record_post_action 09:52:37 INFO - [mozharness: 2017-03-14 16:52:37.721274Z] Finished clobber step (success) 09:52:37 INFO - [mozharness: 2017-03-14 16:52:37.721402Z] Running read-buildbot-config step. 09:52:37 INFO - Running pre-action listener: _resource_record_pre_action 09:52:37 INFO - Running main action method: read_buildbot_config 09:52:37 INFO - Using buildbot properties: 09:52:37 INFO - { 09:52:37 INFO - "project": "", 09:52:37 INFO - "product": "firefox", 09:52:37 INFO - "script_repo_revision": "production", 09:52:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:52:37 INFO - "repository": "", 09:52:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:52:37 INFO - "buildid": "20170314081436", 09:52:37 INFO - "pgo_build": "False", 09:52:37 INFO - "basedir": "/builds/slave/test", 09:52:37 INFO - "buildnumber": 119, 09:52:37 INFO - "slavename": "t-yosemite-r7-0069", 09:52:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:52:37 INFO - "platform": "yosemite_r7", 09:52:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:52:37 INFO - "branch": "mozilla-central", 09:52:37 INFO - "repo_path": "mozilla-central", 09:52:37 INFO - "revision": "2baef2ffbaedb7354286726660ebd36e84b432f0", 09:52:37 INFO - "stage_platform": "macosx64", 09:52:37 INFO - "builduid": "bbf87303c1b446fc8f5175dcad47978e", 09:52:37 INFO - "slavebuilddir": "test" 09:52:37 INFO - } 09:52:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:52:37 INFO - Running post-action listener: _resource_record_post_action 09:52:37 INFO - [mozharness: 2017-03-14 16:52:37.724745Z] Finished read-buildbot-config step (success) 09:52:37 INFO - [mozharness: 2017-03-14 16:52:37.724870Z] Running download-and-extract step. 09:52:37 INFO - Running pre-action listener: _resource_record_pre_action 09:52:37 INFO - Running main action method: download_and_extract 09:52:37 INFO - mkdir: /builds/slave/test/build/tests 09:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:52:37 INFO - trying https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:52:37 INFO - Downloading https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/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 09:52:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/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 09:52:39 INFO - Downloaded 1199 bytes. 09:52:39 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:52:39 INFO - Using the following test package requirements: 09:52:39 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:52:39 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:52:39 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:52:39 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'jsshell-mac.zip'], 09:52:39 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:52:39 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:52:39 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:52:39 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:52:39 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:52:39 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:52:39 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:52:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:52:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:52:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:52:39 INFO - Fetch https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:52:40 INFO - Expected file size: 52468960 09:52:40 INFO - Obtained file size: 52468960 09:52:56 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 09:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:52:58 INFO - Expected file size: 52468960 09:52:58 INFO - Obtained file size: 52468960 09:53:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:53:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:53:13 INFO - Fetch https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:53:14 INFO - Expected file size: 14404452 09:53:14 INFO - Obtained file size: 14404452 09:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:15 INFO - trying https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:53:15 INFO - Downloading https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/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 09:53:17 INFO - Downloaded 74990414 bytes. 09:53:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:53:17 INFO - mkdir: /builds/slave/test/properties 09:53:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:53:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:53:17 INFO - Contents: 09:53:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:53:18 INFO - Running post-action listener: _resource_record_post_action 09:53:18 INFO - Running post-action listener: set_extra_try_arguments 09:53:18 INFO - [mozharness: 2017-03-14 16:53:18.056243Z] Finished download-and-extract step (success) 09:53:18 INFO - [mozharness: 2017-03-14 16:53:18.056362Z] Running populate-webroot step. 09:53:18 INFO - Running pre-action listener: _resource_record_pre_action 09:53:18 INFO - Running main action method: populate_webroot 09:53:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:53:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:53:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:53:18 INFO - '--tppagecycles', 09:53:18 INFO - '7'], 09:53:18 INFO - 'tests': ['tsvgm']}}, 09:53:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:53:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:53:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:53:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:53:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['damp', 'tps']}, 09:53:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'tests': ['damp', 'tps']}, 09:53:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['dromaeo_dom']}, 09:53:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:53:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['basic_compositor_video']}, 09:53:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:53:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['a11yr', 09:53:18 INFO - 'ts_paint', 09:53:18 INFO - 'tpaint', 09:53:18 INFO - 'sessionrestore', 09:53:18 INFO - 'sessionrestore_no_auto_restore', 09:53:18 INFO - 'tabpaint']}, 09:53:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:53:18 INFO - 'ts_paint', 09:53:18 INFO - 'tpaint', 09:53:18 INFO - 'sessionrestore', 09:53:18 INFO - 'sessionrestore_no_auto_restore', 09:53:18 INFO - 'tabpaint']}, 09:53:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:53:18 INFO - 'ts_paint', 09:53:18 INFO - 'tpaint', 09:53:18 INFO - 'sessionrestore', 09:53:18 INFO - 'sessionrestore_no_auto_restore', 09:53:18 INFO - 'tabpaint']}, 09:53:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:53:18 INFO - 'ts_paint', 09:53:18 INFO - 'tpaint', 09:53:18 INFO - 'sessionrestore', 09:53:18 INFO - 'sessionrestore_no_auto_restore', 09:53:18 INFO - 'tabpaint']}, 09:53:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['a11yr', 09:53:18 INFO - 'ts_paint', 09:53:18 INFO - 'tpaint', 09:53:18 INFO - 'sessionrestore', 09:53:18 INFO - 'sessionrestore_no_auto_restore', 09:53:18 INFO - 'tabpaint']}, 09:53:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['a11yr', 09:53:18 INFO - 'ts_paint', 09:53:18 INFO - 'tpaint', 09:53:18 INFO - 'sessionrestore', 09:53:18 INFO - 'sessionrestore_no_auto_restore', 09:53:18 INFO - 'tabpaint']}, 09:53:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['tsvgx', 09:53:18 INFO - 'tsvgr_opacity', 09:53:18 INFO - 'tart', 09:53:18 INFO - 'tscrollx', 09:53:18 INFO - 'cart', 09:53:18 INFO - 'tsvg_static']}, 09:53:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:53:18 INFO - 'tsvgr_opacity', 09:53:18 INFO - 'tart', 09:53:18 INFO - 'tscrollx', 09:53:18 INFO - 'cart', 09:53:18 INFO - 'tsvg_static']}, 09:53:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'talos_options': ['--disable-e10s'], 09:53:18 INFO - 'tests': ['tp5o']}, 09:53:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:53:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'talos_options': ['--disable-e10s', 09:53:18 INFO - '--xperf_path', 09:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:18 INFO - 'tests': ['tp5n']}, 09:53:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:53:18 INFO - 'talos_options': ['--xperf_path', 09:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:18 INFO - 'tests': ['tp5n']}}, 09:53:18 INFO - 'talos.zip': {'path': '', 09:53:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:53:18 INFO - Running post-action listener: _resource_record_post_action 09:53:18 INFO - [mozharness: 2017-03-14 16:53:18.074817Z] Finished populate-webroot step (success) 09:53:18 INFO - [mozharness: 2017-03-14 16:53:18.074950Z] Running create-virtualenv step. 09:53:18 INFO - Running pre-action listener: _resource_record_pre_action 09:53:18 INFO - Running main action method: create_virtualenv 09:53:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:53:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:53:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:53:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:53:18 INFO - Using real prefix '/tools/python27' 09:53:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:53:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:53:21 INFO - Installing pip.................done. 09:53:21 INFO - Return code: 0 09:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:53:22 INFO - Reading from file tmpfile_stdout 09:53:22 INFO - Output received: 09:53:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:53:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:22 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 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:22 INFO - 'HOME': '/Users/cltbld', 09:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:22 INFO - 'LOGNAME': 'cltbld', 09:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:22 INFO - 'MOZ_NO_REMOTE': '1', 09:53:22 INFO - 'NO_EM_RESTART': '1', 09:53:22 INFO - 'PAGER': '/bin/cat', 09:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:22 INFO - 'PWD': '/builds/slave/test', 09:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:22 INFO - 'SHELL': '/bin/bash', 09:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:22 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:22 INFO - 'USER': 'cltbld', 09:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:22 INFO - 'XPC_FLAGS': '0x0', 09:53:22 INFO - 'XPC_SERVICE_NAME': '0', 09:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:53:22 INFO - Cleaning up... 09:53:22 INFO - Return code: 0 09:53:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:22 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 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:22 INFO - 'HOME': '/Users/cltbld', 09:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:22 INFO - 'LOGNAME': 'cltbld', 09:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:22 INFO - 'MOZ_NO_REMOTE': '1', 09:53:22 INFO - 'NO_EM_RESTART': '1', 09:53:22 INFO - 'PAGER': '/bin/cat', 09:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:22 INFO - 'PWD': '/builds/slave/test', 09:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:22 INFO - 'SHELL': '/bin/bash', 09:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:22 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:22 INFO - 'USER': 'cltbld', 09:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:22 INFO - 'XPC_FLAGS': '0x0', 09:53:22 INFO - 'XPC_SERVICE_NAME': '0', 09:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:22 INFO - Downloading/unpacking psutil>=3.1.1 09:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:26 INFO - Installing collected packages: psutil 09:53:26 INFO - Running setup.py install for psutil 09:53:26 INFO - building 'psutil._psutil_osx' extension 09:53:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:53:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:53:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:53:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:53:27 INFO - building 'psutil._psutil_posix' extension 09:53:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:53:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:53:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:53:27 INFO - ^ 09:53:27 INFO - 1 warning generated. 09:53:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:53:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:53:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:53:27 INFO - Successfully installed psutil 09:53:27 INFO - Cleaning up... 09:53:27 INFO - Return code: 0 09:53:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:27 INFO - 'HOME': '/Users/cltbld', 09:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:27 INFO - 'LOGNAME': 'cltbld', 09:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:27 INFO - 'MOZ_NO_REMOTE': '1', 09:53:27 INFO - 'NO_EM_RESTART': '1', 09:53:27 INFO - 'PAGER': '/bin/cat', 09:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:27 INFO - 'PWD': '/builds/slave/test', 09:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:27 INFO - 'SHELL': '/bin/bash', 09:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:27 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:27 INFO - 'USER': 'cltbld', 09:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:27 INFO - 'XPC_FLAGS': '0x0', 09:53:27 INFO - 'XPC_SERVICE_NAME': '0', 09:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:53:30 INFO - Installing collected packages: mozsystemmonitor 09:53:30 INFO - Running setup.py install for mozsystemmonitor 09:53:30 INFO - Successfully installed mozsystemmonitor 09:53:30 INFO - Cleaning up... 09:53:30 INFO - Return code: 0 09:53:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:31 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 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:31 INFO - 'HOME': '/Users/cltbld', 09:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:31 INFO - 'LOGNAME': 'cltbld', 09:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:31 INFO - 'MOZ_NO_REMOTE': '1', 09:53:31 INFO - 'NO_EM_RESTART': '1', 09:53:31 INFO - 'PAGER': '/bin/cat', 09:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:31 INFO - 'PWD': '/builds/slave/test', 09:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:31 INFO - 'SHELL': '/bin/bash', 09:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:31 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:31 INFO - 'USER': 'cltbld', 09:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:31 INFO - 'XPC_FLAGS': '0x0', 09:53:31 INFO - 'XPC_SERVICE_NAME': '0', 09:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:53:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:53:34 INFO - warning: no files found matching '*.txt' 09:53:34 INFO - no previously-included directories found matching 'build' 09:53:34 INFO - no previously-included directories found matching 'dist' 09:53:34 INFO - no previously-included directories found matching '.git*' 09:53:34 INFO - Installing collected packages: jsonschema, functools32 09:53:34 INFO - Running setup.py install for functools32 09:53:34 INFO - warning: no files found matching '*.txt' 09:53:34 INFO - no previously-included directories found matching 'build' 09:53:34 INFO - no previously-included directories found matching 'dist' 09:53:34 INFO - no previously-included directories found matching '.git*' 09:53:34 INFO - Successfully installed jsonschema functools32 09:53:34 INFO - Cleaning up... 09:53:34 INFO - Return code: 0 09:53:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:34 INFO - 'HOME': '/Users/cltbld', 09:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:34 INFO - 'LOGNAME': 'cltbld', 09:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:34 INFO - 'MOZ_NO_REMOTE': '1', 09:53:34 INFO - 'NO_EM_RESTART': '1', 09:53:34 INFO - 'PAGER': '/bin/cat', 09:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:34 INFO - 'PWD': '/builds/slave/test', 09:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:34 INFO - 'SHELL': '/bin/bash', 09:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:34 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:34 INFO - 'USER': 'cltbld', 09:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:34 INFO - 'XPC_FLAGS': '0x0', 09:53:34 INFO - 'XPC_SERVICE_NAME': '0', 09:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:53:35 INFO - Cleaning up... 09:53:35 INFO - Return code: 0 09:53:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:35 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 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:35 INFO - 'HOME': '/Users/cltbld', 09:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:35 INFO - 'LOGNAME': 'cltbld', 09:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:35 INFO - 'MOZ_NO_REMOTE': '1', 09:53:35 INFO - 'NO_EM_RESTART': '1', 09:53:35 INFO - 'PAGER': '/bin/cat', 09:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:35 INFO - 'PWD': '/builds/slave/test', 09:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:35 INFO - 'SHELL': '/bin/bash', 09:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:35 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:35 INFO - 'USER': 'cltbld', 09:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:35 INFO - 'XPC_FLAGS': '0x0', 09:53:35 INFO - 'XPC_SERVICE_NAME': '0', 09:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:53:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:39 INFO - Downloading docopt-0.6.1.tar.gz 09:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:53:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:53:39 INFO - Running setup.py install for blobuploader 09:53:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:53:39 INFO - Running setup.py install for requests 09:53:39 INFO - Running setup.py install for docopt 09:53:40 INFO - Successfully installed blobuploader requests docopt 09:53:40 INFO - Cleaning up... 09:53:40 INFO - Return code: 0 09:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:40 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 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:40 INFO - 'HOME': '/Users/cltbld', 09:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:40 INFO - 'LOGNAME': 'cltbld', 09:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:40 INFO - 'MOZ_NO_REMOTE': '1', 09:53:40 INFO - 'NO_EM_RESTART': '1', 09:53:40 INFO - 'PAGER': '/bin/cat', 09:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:40 INFO - 'PWD': '/builds/slave/test', 09:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:40 INFO - 'SHELL': '/bin/bash', 09:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:40 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:40 INFO - 'USER': 'cltbld', 09:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:40 INFO - 'XPC_FLAGS': '0x0', 09:53:40 INFO - 'XPC_SERVICE_NAME': '0', 09:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:40 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-WOZ2Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:40 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-9PI4id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:40 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-z8jdxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:40 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-FiwzHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:40 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Od3YGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-KdLUeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-b1UYKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-rvI_mK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-BGZ5V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-8Y_hER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-u2lB6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-cLz0DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-j04CeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-qjDrHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:41 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Nc3r35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:42 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-GjgdmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:42 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-rpObAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:53:42 INFO - Running setup.py install for manifestparser 09:53:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:53:42 INFO - Running setup.py install for mozcrash 09:53:42 INFO - Running setup.py install for mozdebug 09:53:42 INFO - Running setup.py install for mozdevice 09:53:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:53:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:42 INFO - Running setup.py install for mozfile 09:53:43 INFO - Running setup.py install for mozhttpd 09:53:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Running setup.py install for mozinfo 09:53:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Running setup.py install for mozInstall 09:53:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Running setup.py install for mozleak 09:53:43 INFO - Running setup.py install for mozlog 09:53:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Running setup.py install for moznetwork 09:53:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:43 INFO - Running setup.py install for mozprocess 09:53:44 INFO - Running setup.py install for mozprofile 09:53:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:44 INFO - Running setup.py install for mozrunner 09:53:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:44 INFO - Running setup.py install for mozscreenshot 09:53:44 INFO - Running setup.py install for moztest 09:53:44 INFO - Running setup.py install for mozversion 09:53:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:44 INFO - Cleaning up... 09:53:44 INFO - Return code: 0 09:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:44 INFO - 'HOME': '/Users/cltbld', 09:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:44 INFO - 'LOGNAME': 'cltbld', 09:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:44 INFO - 'MOZ_NO_REMOTE': '1', 09:53:44 INFO - 'NO_EM_RESTART': '1', 09:53:44 INFO - 'PAGER': '/bin/cat', 09:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:44 INFO - 'PWD': '/builds/slave/test', 09:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:44 INFO - 'SHELL': '/bin/bash', 09:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:44 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:44 INFO - 'USER': 'cltbld', 09:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:44 INFO - 'XPC_FLAGS': '0x0', 09:53:44 INFO - 'XPC_SERVICE_NAME': '0', 09:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-0UumgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-KyGF3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-5gjgjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-IFdgNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-U3QFpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-fKcLtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-EvNIMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-tISJ4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:45 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-RVzHcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-msXqdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-8EVVTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-4yjVmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:46 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)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-aDTIMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-lEmI1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Cs3N5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ZtKdLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:46 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-MtwUmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:53:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:49 INFO - Downloading blessings-1.6.tar.gz 09:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:49 INFO - Installing collected packages: blessings 09:53:49 INFO - Running setup.py install for blessings 09:53:49 INFO - Successfully installed blessings 09:53:49 INFO - Cleaning up... 09:53:50 INFO - Return code: 0 09:53:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:50 INFO - Reading from file tmpfile_stdout 09:53:50 INFO - Current package versions: 09:53:50 INFO - blessings == 1.6 09:53:50 INFO - blobuploader == 1.2.4 09:53:50 INFO - docopt == 0.6.1 09:53:50 INFO - functools32 == 3.2.3-2 09:53:50 INFO - jsonschema == 2.5.1 09:53:50 INFO - manifestparser == 1.1 09:53:50 INFO - mozInstall == 1.12 09:53:50 INFO - mozcrash == 1.0 09:53:50 INFO - mozdebug == 0.1 09:53:50 INFO - mozdevice == 0.49 09:53:50 INFO - mozfile == 1.2 09:53:50 INFO - mozhttpd == 0.7 09:53:50 INFO - mozinfo == 0.9 09:53:50 INFO - mozleak == 0.1 09:53:50 INFO - mozlog == 3.4 09:53:50 INFO - moznetwork == 0.27 09:53:50 INFO - mozprocess == 0.25 09:53:50 INFO - mozprofile == 0.28 09:53:50 INFO - mozrunner == 6.13 09:53:50 INFO - mozscreenshot == 0.1 09:53:50 INFO - mozsystemmonitor == 0.3 09:53:50 INFO - moztest == 0.8 09:53:50 INFO - mozversion == 1.4 09:53:50 INFO - psutil == 3.1.1 09:53:50 INFO - requests == 1.2.3 09:53:50 INFO - wsgiref == 0.1.2 09:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:50 INFO - 'HOME': '/Users/cltbld', 09:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:50 INFO - 'LOGNAME': 'cltbld', 09:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:50 INFO - 'MOZ_NO_REMOTE': '1', 09:53:50 INFO - 'NO_EM_RESTART': '1', 09:53:50 INFO - 'PAGER': '/bin/cat', 09:53:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:50 INFO - 'PWD': '/builds/slave/test', 09:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:50 INFO - 'SHELL': '/bin/bash', 09:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:50 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:50 INFO - 'USER': 'cltbld', 09:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:50 INFO - 'XPC_FLAGS': '0x0', 09:53:50 INFO - 'XPC_SERVICE_NAME': '0', 09:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:53:50 INFO - Cleaning up... 09:53:50 INFO - Return code: 0 09:53:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107091b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107094768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa33c74110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, '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.tPXkZrz2hL/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.jysL54Y6iy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:53: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', 'jsonschema'] in /builds/slave/test/build 09:53: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 jsonschema 09:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:53:50 INFO - 'HOME': '/Users/cltbld', 09:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:53:50 INFO - 'LOGNAME': 'cltbld', 09:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:50 INFO - 'MOZ_NO_REMOTE': '1', 09:53:50 INFO - 'NO_EM_RESTART': '1', 09:53:50 INFO - 'PAGER': '/bin/cat', 09:53:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:50 INFO - 'PWD': '/builds/slave/test', 09:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:53:50 INFO - 'SHELL': '/bin/bash', 09:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:53:50 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:53:50 INFO - 'USER': 'cltbld', 09:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:50 INFO - 'XPC_FLAGS': '0x0', 09:53:50 INFO - 'XPC_SERVICE_NAME': '0', 09:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:53:50 INFO - Cleaning up... 09:53:50 INFO - Return code: 0 09:53:50 INFO - Running post-action listener: _resource_record_post_action 09:53:50 INFO - Running post-action listener: _start_resource_monitoring 09:53:50 INFO - Starting resource monitoring. 09:53:50 INFO - [mozharness: 2017-03-14 16:53:50.851556Z] Finished create-virtualenv step (success) 09:53:50 INFO - [mozharness: 2017-03-14 16:53:50.852500Z] Running install step. 09:53:50 INFO - Running pre-action listener: _resource_record_pre_action 09:53:50 INFO - Running main action method: install 09:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:51 INFO - Reading from file tmpfile_stdout 09:53:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:51 INFO - Reading from file tmpfile_stdout 09:53:51 INFO - Output received: 09:53:51 INFO - Usage: mozinstall [options] installer 09:53:51 INFO - Options: 09:53:51 INFO - -h, --help show this help message and exit 09:53:51 INFO - -d DEST, --destination=DEST 09:53:51 INFO - Directory to install application into. [default: 09:53:51 INFO - "/builds/slave/test"] 09:53:51 INFO - --app=APP Application being installed. [default: firefox] 09:53:51 INFO - mkdir: /builds/slave/test/build/application 09:53:51 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'] 09:53:51 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 09:54:11 INFO - Reading from file tmpfile_stdout 09:54:11 INFO - Output received: 09:54:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:54:11 INFO - Running post-action listener: _resource_record_post_action 09:54:11 INFO - [mozharness: 2017-03-14 16:54:11.733424Z] Finished install step (success) 09:54:11 INFO - [mozharness: 2017-03-14 16:54:11.733571Z] Running run-tests step. 09:54:11 INFO - Running pre-action listener: _resource_record_pre_action 09:54:11 INFO - Running main action method: run_tests 09:54:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:54:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:54:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:54:11 INFO - 2017-03-14 09:54:11.748 screenresolution[1622:7264] starting screenresolution argv=screenresolution get 09:54:11 INFO - 2017-03-14 09:54:11.750 screenresolution[1622:7264] Display 0: 1600x1200x32@60 09:54:11 INFO - 2017-03-14 09:54:11.756 screenresolution[1623:7266] starting screenresolution argv=screenresolution list 09:54:11 INFO - Available Modes on Display 0 09:54:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:54:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:54:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:54:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:54:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:54:11 INFO - Intel Iris: 09:54:11 INFO - Chipset Model: Intel Iris 09:54:11 INFO - Type: GPU 09:54:11 INFO - Bus: Built-In 09:54:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:54:11 INFO - Vendor: Intel (0x8086) 09:54:11 INFO - Device ID: 0x0a2e 09:54:11 INFO - Revision ID: 0x0009 09:54:11 INFO - Displays: 09:54:11 INFO - Display: 09:54:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:54:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:54:11 INFO - Display Serial Number: 1600x1200 60 09:54:11 INFO - Main Display: Yes 09:54:11 INFO - Mirror: Off 09:54:11 INFO - Online: Yes 09:54:11 INFO - Rotation: Supported 09:54:11 INFO - Return code: 0 09:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:54:11 INFO - Python 2.7.3 09:54:11 INFO - Return code: 0 09:54:11 INFO - grabbing minidump binary from tooltool 09:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:11 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 0x106e6fd30>, '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 0x106d96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e64be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:54:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:54:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:54:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:54:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:54:12 INFO - Return code: 0 09:54:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:54:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:54:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:54:12 INFO - ENV: RUST_BACKTRACE is now 1 09:54:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:54:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tPXkZrz2hL/Render', 09:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:54:12 INFO - 'HOME': '/Users/cltbld', 09:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:54:12 INFO - 'LOGNAME': 'cltbld', 09:54:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:54:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:12 INFO - 'MOZ_NO_REMOTE': '1', 09:54:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:54:12 INFO - 'NO_EM_RESTART': '1', 09:54:12 INFO - 'PAGER': '/bin/cat', 09:54:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:12 INFO - 'PWD': '/builds/slave/test', 09:54:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:54:12 INFO - 'RUST_BACKTRACE': '1', 09:54:12 INFO - 'SHELL': '/bin/bash', 09:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jysL54Y6iy/Listeners', 09:54:12 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 09:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:54:12 INFO - 'USER': 'cltbld', 09:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:12 INFO - 'XPC_FLAGS': '0x0', 09:54:12 INFO - 'XPC_SERVICE_NAME': '0', 09:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:54:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:54:12 INFO - mozversion application_buildid: 20170314081436 09:54:12 INFO - mozversion application_changeset: 2baef2ffbaedb7354286726660ebd36e84b432f0 09:54:12 INFO - mozversion application_display_name: Nightly 09:54:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:54:12 INFO - mozversion application_name: Firefox 09:54:12 INFO - mozversion application_remotingname: firefox 09:54:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:54:12 INFO - mozversion application_vendor: Mozilla 09:54:12 INFO - mozversion application_version: 55.0a1 09:54:12 INFO - mozversion platform_buildid: 20170314081436 09:54:12 INFO - mozversion platform_changeset: 2baef2ffbaedb7354286726660ebd36e84b432f0 09:54:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:54:12 INFO - mozversion platform_version: 55.0a1 09:54:12 INFO - using testdate: 1489510452 09:54:12 INFO - actual date: 1489510452 09:54:12 INFO - starting webserver on 'localhost:49241' 09:54:12 INFO - SUITE-START | Running 2 tests 09:54:12 INFO - TEST-START | dromaeo_css 09:54:12 INFO - operating with platform_type : mac_ 09:54:12 INFO - Initialising browser for dromaeo_css test... 09:54:12 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpqJrZtT/profile http://localhost:49241/getInfo.html) 09:54:15 INFO - PID 1633 | 2017-03-14 09:54:15.315 plugin-container[1635:7445] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 09:54:15 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:15 INFO - PID 1633 | 2017-03-14 09:54:15.318 plugin-container[1635:7445] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 09:54:15 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:15 INFO - PID 1633 | 2017-03-14 09:54:15.318 plugin-container[1635:7445] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:54:15 INFO - PID 1633 | __metrics Screen width/height:1600/1200 09:54:15 INFO - PID 1633 | colorDepth:24 09:54:15 INFO - PID 1633 | Browser inner width/height: 1024/689 09:54:15 INFO - PID 1633 | __metrics 09:54:15 ERROR - PID 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:54:16 INFO - TEST-INFO | 1633: exit 0 09:54:16 INFO - Browser initialized. 09:54:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:54:16 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpqJrZtT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:18 INFO - PID 1636 | 2017-03-14 09:54:18.494 plugin-container[1637:7573] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 09:54:18 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:18 INFO - PID 1636 | 2017-03-14 09:54:18.496 plugin-container[1637:7573] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 09:54:18 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:54:18 INFO - PID 1636 | 2017-03-14 09:54:18.496 plugin-container[1637:7573] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:54:28 INFO - PID 1636 | RSS: Main: 227930112 09:54:28 INFO - PID 1636 | 09:57:31 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:57:33 INFO - PID 1636 | RSS: Main: 251768832 09:57:33 INFO - PID 1636 | 09:59:16 INFO - PID 1636 | ************************* 09:59:16 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:59:16 INFO - PID 1636 | 09:59:16 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:59:16 INFO - PID 1636 | Full stack: 09:59:16 INFO - PID 1636 | ************************* 10:00:35 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:00:36 INFO - PID 1636 | RSS: Main: 258215936 10:00:36 INFO - PID 1636 | 10:03:38 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:03:39 INFO - PID 1636 | RSS: Main: 269549568 10:03:39 INFO - PID 1636 | 10:06:40 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:06:41 INFO - PID 1636 | RSS: Main: 262172672 10:06:41 INFO - PID 1636 | 10:09:44 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:09:45 INFO - PID 1636 | RSS: Main: 272429056 10:09:45 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:12:48 INFO - PID 1636 | RSS: Main: 266981376 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | __start_tp_report 10:12:48 INFO - PID 1636 | _x_x_mozilla_page_load 10:12:48 INFO - PID 1636 | _x_x_mozilla_page_load_details 10:12:48 INFO - PID 1636 | |i|pagename|runs| 10:12:48 INFO - PID 1636 | |0;dojo.html;3224.935771195506;3369.174552234703;3381.8985430437097;3432.708219801318;3457.135716070982;4536.500984891659;5927.585069045158;6000.919834429801;6006.189164462796;6095.268567771863;5916.3787802280785;5986.521078313735;6004.639721616706;6080.027195648697;6103.755849766004;5358.115910874701;5395.947790180916;5402.9729851350685;5459.153831156157;5511.807086751965;4869.948674784778;5416.83749487516;5511.751971161308;5531.2809334786425;5578.748956296956;5340.572754179656;5383.784648614051;5448.863778405532;5461.972690136564;5493.450654934514;4410.691251612388;5381.569474442074;5390.380106287748;5415.1335786274;5447.918281225785;5330.040592693314;5368.463153684639;5368.973155134238;5389.380221274564;5393.622446428752;5818.941810581882;5866.794662186846;5867.70661466925;5895.086261629454;5995.940040599626;5759.107338362561;6064.666443345614;6291.02489114188;6339.302676705559;6357.682115894233;6403.551751377406;6436.3241859605005;6437.710303036328;6445.581037232565;6448.709808058648;6132.202813634288;6141.293751218623;6153.784617538454;6159.6612186330185;6165.599236049642;6307.274663413675;6373.681315934185;6473.676316184172;6499.642519661369;6503.8699226015215;4955.677880937799;6096.466212027279;6117.675163990694;6187.81436556895;6250.562460627803;5331.413544510101;6287.937120628735;6299.149614802035;6333.303336632966;6395;6076.754265375587;6268.279147897959;6339.207599050119;6348.460380867586;6366.681665916685;5170.870728231825;5938.940610593839;6304.527160462983;6306.274778400542;6331.335209802996;3654.5747158608165;4296.312589985588;5041.0422019816115;5073.568746656501;5151.2530683050745;4647;4651.883702907455;4653.371794807726;4659.697119687209;4673.112108699404;6104.053871649901;6106.1146133811235;6127.111568822495;6128.754849805958;6136.23297087864;6238.157848690369;6297;6449.871002579922;6493.123428337209;6497;6033.3061697905305;6082.908756368658;6110.694465276719;6133.969330153321;6140.969295153495;5703.458171473703;5717.742701578439;5723.971380143156;5724.942750572441;5750.022496175577;6396.296407395276;6563.212414510289;6574.441172500391;6642.036904648896;6653.800385988428;5736.827895163152;5772.81657260269;6185.41238582334;6380.776672816429;6465.2564955030775;6573.375529324707;6586.110875032001;6634.203895532374;6642.933570664425;6652.434543063894;6248.781292654735;6309.684515774101;6336.714847831767;6337.112804207322;6347.746090156526;6188.319284878569;6251.68741562911;6367.681615919093;6415.326390729093;6425.839354016;6126.509879209563;6176.845578860564;6203.2245969253845;6249.843753906189;6251.9687401562705;6108.584917381041;6147.108669242845;6221.502279817694;6238.376162383725;6249.750009999549;6041.69791510414;6103.694815259308;6143.600665956698;6214.564980451506;6220.098085777628;6152.323244443197;6200.658963757037;6222.844428889314;6259.06114082873;6259.186305780219;6137.8060289514;6160.7535698571555;6221.5333849960525;6229.750809967551;6234 10:12:48 INFO - PID 1636 | |1;ext.html;709.9858002839943;772.3396495995923;792.144483957326;919.9908000919997;929.2380248196481;30468.476576171186;37035;37597.060073498105;37659;37669.62330376699;36288.455673164855;36379.4543081854;37295;37362;37460.81269593655;7621;7820.687172513092;10514.579416823357;10810.837837432446;10834.891651083506;10673.78652426951;10760.461976901162;10823.404712740796;10825.133989280877;10834.891651083506;9369.718908432758;10775.784484310308;10878.782424351548;11003.889961100367;11027.117830573536;10896.073833724144;10903.672889813319;10948.343099413982;10961.232713710044;10963.232573719843;10728.195385346053;10805.351678899291;10813.405262710548;10837.566497340096;10841.186910981707;37471.81264093689;37635.62364376349;37682.62317376819;37707.43438848392;37881.0529736756;3862.1117143057254;3871.8838434847;3900.3759398496386;3932.5477570079233;4034.3141665916864;27755;27778.305542361402;27834.3041423964;27914;27942.301442463897;3102.1158969693756;3115.8597863096215;3229.031290612807;3235.9420347771365;3241.9625719769683;323250;324294;325108;325272;325291;49623.007539849;49781.0043799122;49908.50091499111;50084.74788130326;50088;51455.97088058218;51508.484915151115;51525;51554.48445515572;51575.484245157815;14657.267136643126;14694.485693000694;14744.63138421548;14845.92577037108;14927.552173434815;11913.58302459427;11970.640880773592;11981.221220620631;12003.51985920571;12014.939925300318;11202.94398528002;13754.518591849237;13777.448902044007;13784.517541885985;13873.445062197601;4971.776270067856;5855.180274761537;5915.615484993462;5922.615030023035;5953.553483488669;1144.690933447981;1145.3986657004973;1147.6958605969426;1154.717094311899;1197.9161458697808;22554.21060262916;26166.86916565405;26262.395080278886;26486.337841554116;26505.46989060208;1169.3101070368523;1240.1504969096197;1253.5487224599137;1296.5786119511197;1302.257713103541;13514.662133446742;15336;15516.689666206612;15557.22213889301;15872.841271587136;425184;427819;430098;430145;430643;58254.12618810721;58793;58831.411685882595;58925.41074589285;59113;1227.6562562482698;1375.9931200343933;1423.8149040624653;1427.835798883121;1443.4659176104908;18837.80830471448;28180.85909570521;29135.125946221648;29199.416011679223;30501.54247686242;52858.67853303698;53041.20438193507;53306.933861323334;53363.733181333846;53390.46609533855;443726;445295.7735211303;448090;448501;449810;32951.835240823646;33228.50157247595;33945.830270848484;33949.83025084859;34038.65961340355;41637.79181104075;42125;42343;42409.78795106005;42583.36124958066;34035.48946765751;34163.31673366469;34234;35092.298154037286;35142.64857351496;26819.86590067037;35094.473582895764;35165;36119;36709.08227294339;35375.938721838385;35935.64064359428;35955.101122472144;36020.81989590035;36306.27387452289;30288.788448462696;31811.36377272488;31814.52278215875;31832.5225121628;32044.51933220957;21084.31325493926;22460.887695561418;22741.09035638622;23702.407439814142;24768.752312476645 10:12:48 INFO - PID 1636 | |2;jquery.html;359.8021088401379;396.136422598735;403.3647005965605;408.6016134269087;422.9767362795045;19869.701954470693;21549.353519394423;21715.02282397292;22213.444663883412;22244.443888902784;19690.310839120633;20502.17991280351;21128.788712112873;22361.10555577779;22530;6200.937990620104;6318.589291696048;6859.176898772154;6877.931220687804;6913.1358580177475;6704.73181072759;6828.556143850658;7459.104907411118;7815.2966233039015;7879.4484386093;7720.459567830254;7857.057153141603;7858.410619203554;7864.960675196616;7876.448648594601;7558.62206889656;7796.376289896852;7810.882836757425;7825.569593672346;7858.214178582153;6786.966065169692;7323.121225452926;7607.695692172307;7672.079350477922;7727.49771264866;27534.724652753415;29168.124956251348;29836;29900.85049574738;30191.698083019328;3384.4077286474767;3392.8473218705217;3454.5336379588684;3456.6888979991922;3564.144605294711;16613.335466581324;16872.91563542187;16952.49142525714;17087.316507339692;17460.30158793647;2040.2553068130026;2046.549759053006;2050.9487262818398;2054.209129485144;2057.989710051455;107088.85822283589;138672;140139;140145;143764;18950;19967.800321996885;24196.790160491906;25914.740852591232;26278.73721262801;41443.37834932478;42002;42279.577204227564;42364.94087647834;42469;11189.160812939062;11325.546978120949;11359.48882300282;11538.423078846025;11592.536298547964;8866.822663546693;8906;8948.970868350223;9102.226310763659;9111.997680255166;9819.312648114563;11875.228110172811;12098.395080245953;12219.633410997685;12389.93805030969;4008.599140085968;4722.291656251521;4799.752064463265;4853.466118726938;4875.926861097087;836.1011912194415;854.645322191296;854.7307598106577;856.3063918226256;883.3021912688904;24053.278401647978;24444.899979500966;24450;24462.755372446405;24541.63187552188;805.9314958228616;820.2330820682681;917.499962520428;948.9193418559499;951.7477868364889;12617.179883307555;12663;12792;12888.935555322163;12995.870041299466;686822;696463;700704;702287;709164;107158;107239;112620;148142.259288705;149394;1207.106741011645;1214.9635510934686;1251.1117106854053;1252.2111070025826;1259.5024965138903;20417.59164816725;21910;21975.34073977719;22167.44581385478;22222.444438889157;61706.69146654417;62381;62507.06239406503;62815;63061.36938630555;87914;88161.55919220363;88705.66941496012;88857.66713499432;88969.55515222382;12001.75996480048;12605;12641.557545485864;12668.556600518938;12730.96304591261;10845.457727113455;11146.832797508207;13987;14357.21035343066;14458.349374277972;11497.252678575866;11591.478383472933;11727.41362931833;11729.120315976506;11897.167198296036;10063.993600639877;11469.541218351505;11551.537938482703;11875.465604048011;11962.641120766391;11608.88391116078;11921.105917056082;11923.9864611509;12124.75750485003;12229.633111006684;12797.936010319889;12816.807747883602;13081.345932703518;13126.737465250451;13209;10113.747156321151;11747.588834391097;11890.524379024742;11923.403829808649;11932.940335298268 10:12:48 INFO - PID 1636 | |3;mootools.html;1470.5000299898036;1517.1958861803248;1530.724469595473;1550.356602010166;1580.7391780356243;9222.584983675733;9607.27945404094;10433.582656693732;10813.35119892806;10897.291676041052;10109.646162384319;10733.51699173537;10754.838677419844;10788.676339709802;10932.125429965603;2308.873011984336;2362.2204672458133;2365.1721897335965;2366.8579885206855;2367;2313.5141620259765;2340.719113706358;2351.5884720173985;2352.188494969241;2352.764723527651;2285.565742508918;2310.2260742651233;2323.732770731362;2328.580855446019;2328.895199716017;2280.737715162761;2289.427643089228;2299.6435552489393;2301.390131615123;2307.826912981533;2234.1175235781775;2258.3450799268194;2266.3994041578994;2276.055436993646;2298.97701022991;10908;10986.230963832535;10996;11023.779524409547;11028.172887033505;5224.92162617561;5404.594655400861;5412.296401467784;5418;5421.620486565942;3288.375208710361;3313.5858017747782;3413.0784688134063;3588.4617307404096;3608.783472991629;1110.5946329589722;1147.8966892979588;1183.9171258011943;1223.3027174510532;1225.1424003197797;13067.803982940264;13942.790858137034;15263.618409539738;15294;15467.149306788122;4659.828609611371;4794.2808578713475;4808.783604737725;4901.901961960741;4930.457649658535;10501.842472362921;12638.873611263769;12652.051096167825;12658.367081645882;12680.175788573713;4929.408470983433;5837.88324233513;5852.648841069549;5871.735771890275;5885.411458854081;4386.561343865588;4826.203676393426;5037.345145131109;5129.615278854101;5196.350456192976;3924.7056470764805;4003.499562554681;4058.6955978301744;4090.0592863640936;4092.0383709828166;1131.9830202546968;1136.0343707848263;1136.3409222650844;1147.75897061618;1169.7017260598493;783.1815752538611;949.4018768176005;960.2270172511056;961.9230461563059;997.1972562087444;6329.620222786648;6448.161738973903;6608.7356505739235;6621.238557565845;6683.164604424447;899.6896070855545;1023.7491814505345;1061.9256652034437;1074.8280275155937;1076.7738774857369;4141.316682747313;4239.300515414983;4249.447571815645;4360.2587560114225;4375.693701440869;13209.603711888658;13558.661033474045;13625.18248905049;13673.658158545917;13813.309334533233;11825.822612660817;12645.43095560702;13547.119437236548;13566.796498052538;13605.183688978694;8859.601317940707;9138.862917056249;10001.299909006446;10019.79960400788;10034.347767395097;6536.640484773383;6622.90065649006;6832.795016149524;6868.175818901564;6884.8967265490055;11638.70903227426;11762.94118529402;11809.527618895492;11920.463579139134;11937.46281417321;11491.655250342503;11853.703657408634;11990.820137698116;12036.398180091135;12052.09609279325;7804.765857024298;8249.546274954935;8756.51839148853;9208.355415120877;9309.487978161265;9957.850632240667;10101.191904647758;10191.184705223712;10208.744781380525;10239.334443261165;8811.60347784364;8865.24645405122;8869.955650221707;8989.325800565115;9011.909880901107;8008.758642410436;8205.261526462407;8721.302295816446;8815.338849586178;8831.779205519913;7769.6892124316655;7792.84414311722;7864.1742617026675;7880.369570434466;7881.487703299267;5920;5946.13781001761;5981.850453738692;6003.519718422603;6016.789412370546;5935.228420305332;5954.76180952757;5999;6073.817785466443;6083.726232319645 10:12:48 INFO - PID 1636 | |4;prototype.html;352.80595672380184;377.2040993503708;378.40968089779943;387.25840016368636;394.7256656623647;6150.938490615093;6162.568620196583;6237.46981506572;6292.9685351573235;6328.905066424008;5278.392984806748;6034.517238620911;6143.723532441039;6194.287656919456;6207.627542347463;4097.364908439182;4377.6716746244;4879.585235255007;5024.171011783052;5101.464346243656;4726;4772.3968403855215;5056.595472362221;5122.8207012754565;5129.358830146231;5067.113255180348;5102.540771330579;5113.43752187261;5117.872053198663;5122.820701275437;3960;4300.784960751966;4879.341288926003;5060.139776238048;5079.8222062228015;4527.253003254459;4587.197240482902;4593.425821772278;4603.194440972849;4615.723056616614;5052.621053420971;5212.774997875496;5306.787728490855;5598.552115830765;6080.05438259757;4351.843988990507;5570.3315602128005;5591.9720401398135;5727.713614319309;5835.024137689767;5908.852278693067;6639.73441062357;6654;6672.599644021374;6713.4964877634375;4012.979935100335;4615.169269531517;4782.473927867932;4970.906400591864;5020.6946193989825;6043.848903777397;6238.438540531374;6637.7013034413085;6735.595864248161;7003.92996070043;5285.9735701322015;5306.8407947761625;5319.164873137999;5360.946390536123;5379.246905433164;5402.405735369106;5419.403865574784;5423.810166644149;5437.483439073281;5445.992491389026;4412.911741765147;4606.424196975378;4921.892574170783;5595.860103497445;5876.883392155477;6652.168478940132;6660.70026848793;6674.432673222734;6680.229739119137;6689.6989635466525;1641.9014859108493;1766.275826910986;1851.7407562941198;1854.8608854335978;1866.188208129468;1146.512732088859;1234.5617305856472;1337.037333120152;1346.8518462969066;1367.3300082959279;5474.2609747683555;6237.1891654084675;6248.50011999039;6265.4361107500545;6325.335839736854;6537.934620653733;6885.311468853175;6890.2420733719255;6923.515353925278;6937.618430986243;5960.284765828042;6202.41077097675;6205.689715514206;6260.24877014752;6264.9373506265265;3580.230250496156;3607.981960090183;3618.5706645874734;3620.7189470633857;3621.293847699726;6823.283555226729;7119.288071192839;7168.498205125696;7183.209846916835;7204.747833825791;5452.945470545323;7105.609191494517;7150.713971441188;7198.604076775723;7200.495965282485;6234.657093859882;6534.758395904762;7155.463340249502;7159.89260161098;7201;5440.428754980829;6552.508561857975;6885.827854303682;6969.930300697131;6985.231624521197;5004.47453017428;5499.395066542757;5517.531009864046;6188.566800323934;6590.308017658269;6780.355866192704;7059.611721355374;7134.821629459305;7136.395215746319;7150.570965741864;5135.6918584885025;5259.368875734936;5358.35699716021;5365.651232669864;5386.730663466889;5610.831675049755;5950.464458198783;6891.069705589882;6904.447644188353;6946.826329341807;6335.3981371769605;6466.32103629131;6651.667416629246;6684.665766711548;6687.8328041797395;6557.836054098686;6590.209174899042;6643.900341494785;6666.166729158856;6701.32986701326;6493.935060649333;6526.902096468461;6526.967365163144;6527.51043671717;6535.705893234911;6396.136521569529;6659.467242620675;6665;6669.266380698216;6725.260221375743;5421.83734487966;6044.214252147192;6566.244881838458;6579.671016449062;6593.80218593443 10:12:48 INFO - PID 1636 | |5;yui.html;666.5034549260798;700.3346820520507;713.414999700246;808.6037841457686;815.9224873637005;14866.47967321144;14920.850791492081;15501.534953951399;15625.453109141183;15708.921455392721;11774.941125294361;14626.780598291034;14720.779188312184;14950.252487375643;15008.924955375207;932.1470854168427;966.5119114846992;967.0909345215475;967.3567077893227;969.3941286695815;941.6610020392653;952.9904700952972;953.2516974175273;981.3915372469079;987.3680844259679;1025.5077562769875;1029.4183786160795;1032.230987914005;1032.7573020340214;1036.7978244242377;1008.9495525223709;1027.1885210683552;1028.1825948371027;1029.377226777796;1029.7991891581144;753.1677496366491;765.1774342581691;765.3226894198618;765.6133652505449;765.9157492675802;16091.678166436723;16466.75299870503;16547.917260413622;16802.495925122264;16943.57641058971;14556.417743290256;14741.336639851232;14776.556703298918;14871.776923346159;14887.18120503372;11624;11651.300921944625;11731.824022639667;11919.702007449796;12016.519339226508;3267.232200432896;3685.1892583631557;3701.833417496219;3722.143906901401;3853.3064048471265;73109;113056.43471782589;113856;114836.4258178712;115645;11299.265547739371;11324.716882078013;11486.368249746343;11816.940915295541;11876.465559049864;22873.88563057174;24963.87518062398;25213.24360269195;25227.74772252291;25341.87329063343;7899.407544434191;7929.365650747926;7971.601419929097;8063.879041814377;8200.58997050157;4252.808623611945;4271.829126834954;4375.628071613948;4423;4435.933460998088;3250.593675790526;3309.983450082734;3535.487354333607;3563.465480177994;3565.607783143852;614.5176036811082;619.6560908695627;625.7841044839523;625.9311475737666;639.3766078073841;561.3659242949426;598.7096258314714;604.7641419846263;628.707650942314;632.5761739634364;9935.950320248352;10116.74708132288;10258.948705256425;10271.589136434459;10480;649.4317472211815;680.3740558686021;692.8025512728848;694.2051351202845;694.3820000199826;4509.429625113719;4901.29474712516;4910.926336104962;4994.475580064113;5005.3242812220615;52726.73636631792;72575.91136132962;75444.62277688576;87892;96582.51708741412;78690;80286.99282517984;81239.18760812434;83449;83753;72691.90962135572;72899.26154799921;74473;75726.24273757302;76065.23934760582;10452.895471045496;10808.513616887101;10851.240413171003;10873.293235939638;11026.889731102907;45144.54855451403;45753.54246457626;45781.08437831158;48301.27548086852;48821.53535393944;66317;66507.66746166238;66640.33359666535;67669.66165169142;68353.6582317105;13414.262215577846;13498.257595832323;13597;13791.724165516835;13911.373988170355;14425.639359016108;14555.41778328855;14704.632384190481;14707.632309191928;15188.392464301303;10864.837027444753;11344.943275283571;13614.727705446034;14092.506762263682;14281.64295892611;11256.228482858034;11609;11903.761924761284;12103.455344509342;12193.69515762113;13155;13290.807016842113;13531.59405217845;13587.388567514288;14370.13779173253;11056.944715276371;11057.22599418033;11257;11266.324020558794;11427.085833133164;7965.641546130554;9251.76870578241;9274.768130796783;10864.251723415557;11322.94338528302 10:12:48 INFO - PID 1636 | __end_tp_report 10:12:48 INFO - PID 1636 | __start_cc_report 10:12:48 INFO - PID 1636 | _x_x_mozilla_cycle_collect,422 10:12:48 INFO - PID 1636 | __end_cc_report 10:12:48 INFO - PID 1636 | __startTimestamp1489511568729__endTimestamp 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | ------- Summary: start ------- 10:12:48 INFO - PID 1636 | Number of tests: 6 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:5874.52 Median:6132.20 stddev:694.34 (11.3%) stddev-sans-first:664.64 10:12:48 INFO - PID 1636 | Values: 3224.9 3369.2 3381.9 3432.7 3457.1 4536.5 5927.6 6000.9 6006.2 6095.3 5916.4 5986.5 6004.6 6080.0 6103.8 5358.1 5395.9 5403.0 5459.2 5511.8 4869.9 5416.8 5511.8 5531.3 5578.7 5340.6 5383.8 5448.9 5462.0 5493.5 4410.7 5381.6 5390.4 5415.1 5447.9 5330.0 5368.5 5369.0 5389.4 5393.6 5818.9 5866.8 5867.7 5895.1 5995.9 5759.1 6064.7 6291.0 6339.3 6357.7 6403.6 6436.3 6437.7 6445.6 6448.7 6132.2 6141.3 6153.8 6159.7 6165.6 6307.3 6373.7 6473.7 6499.6 6503.9 4955.7 6096.5 6117.7 6187.8 6250.6 5331.4 6287.9 6299.1 6333.3 6395.0 6076.8 6268.3 6339.2 6348.5 6366.7 5170.9 5938.9 6304.5 6306.3 6331.3 3654.6 4296.3 5041.0 5073.6 5151.3 4647.0 4651.9 4653.4 4659.7 4673.1 6104.1 6106.1 6127.1 6128.8 6136.2 6238.2 6297.0 6449.9 6493.1 6497.0 6033.3 6082.9 6110.7 6134.0 6141.0 5703.5 5717.7 5724.0 5724.9 5750.0 6396.3 6563.2 6574.4 6642.0 6653.8 5736.8 5772.8 6185.4 6380.8 6465.3 6573.4 6586.1 6634.2 6642.9 6652.4 6248.8 6309.7 6336.7 6337.1 6347.7 6188.3 6251.7 6367.7 6415.3 6425.8 6126.5 6176.8 6203.2 6249.8 6252.0 6108.6 6147.1 6221.5 6238.4 6249.8 6041.7 6103.7 6143.6 6214.6 6220.1 6152.3 6200.7 6222.8 6259.1 6259.2 6137.8 6160.8 6221.5 6229.8 6234.0 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:54591.81 Median:324701.00 stddev:106891.49 (32.9%) stddev-sans-first:107114.80 10:12:48 INFO - PID 1636 | Values: 710.0 772.3 792.1 920.0 929.2 30468.5 37035.0 37597.1 37659.0 37669.6 36288.5 36379.5 37295.0 37362.0 37460.8 7621.0 7820.7 10514.6 10810.8 10834.9 10673.8 10760.5 10823.4 10825.1 10834.9 9369.7 10775.8 10878.8 11003.9 11027.1 10896.1 10903.7 10948.3 10961.2 10963.2 10728.2 10805.4 10813.4 10837.6 10841.2 37471.8 37635.6 37682.6 37707.4 37881.1 3862.1 3871.9 3900.4 3932.5 4034.3 27755.0 27778.3 27834.3 27914.0 27942.3 3102.1 3115.9 3229.0 3235.9 3242.0 323250.0 324294.0 325108.0 325272.0 325291.0 49623.0 49781.0 49908.5 50084.7 50088.0 51456.0 51508.5 51525.0 51554.5 51575.5 14657.3 14694.5 14744.6 14845.9 14927.6 11913.6 11970.6 11981.2 12003.5 12014.9 11202.9 13754.5 13777.4 13784.5 13873.4 4971.8 5855.2 5915.6 5922.6 5953.6 1144.7 1145.4 1147.7 1154.7 1197.9 22554.2 26166.9 26262.4 26486.3 26505.5 1169.3 1240.2 1253.5 1296.6 1302.3 13514.7 15336.0 15516.7 15557.2 15872.8 425184.0 427819.0 430098.0 430145.0 430643.0 58254.1 58793.0 58831.4 58925.4 59113.0 1227.7 1376.0 1423.8 1427.8 1443.5 18837.8 28180.9 29135.1 29199.4 30501.5 52858.7 53041.2 53306.9 53363.7 53390.5 443726.0 445295.8 448090.0 448501.0 449810.0 32951.8 33228.5 33945.8 33949.8 34038.7 41637.8 42125.0 42343.0 42409.8 42583.4 34035.5 34163.3 34234.0 35092.3 35142.6 26819.9 35094.5 35165.0 36119.0 36709.1 35375.9 35935.6 35955.1 36020.8 36306.3 30288.8 31811.4 31814.5 31832.5 32044.5 21084.3 22460.9 22741.1 23702.4 24768.8 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:41383.57 Median:23291.64 stddev:115828.17 (497.3%) stddev-sans-first:116112.14 10:12:48 INFO - PID 1636 | Values: 359.8 396.1 403.4 408.6 423.0 19869.7 21549.4 21715.0 22213.4 22244.4 19690.3 20502.2 21128.8 22361.1 22530.0 6200.9 6318.6 6859.2 6877.9 6913.1 6704.7 6828.6 7459.1 7815.3 7879.4 7720.5 7857.1 7858.4 7865.0 7876.4 7558.6 7796.4 7810.9 7825.6 7858.2 6787.0 7323.1 7607.7 7672.1 7727.5 27534.7 29168.1 29836.0 29900.9 30191.7 3384.4 3392.8 3454.5 3456.7 3564.1 16613.3 16872.9 16952.5 17087.3 17460.3 2040.3 2046.5 2050.9 2054.2 2058.0 107088.9 138672.0 140139.0 140145.0 143764.0 18950.0 19967.8 24196.8 25914.7 26278.7 41443.4 42002.0 42279.6 42364.9 42469.0 11189.2 11325.5 11359.5 11538.4 11592.5 8866.8 8906.0 8949.0 9102.2 9112.0 9819.3 11875.2 12098.4 12219.6 12389.9 4008.6 4722.3 4799.8 4853.5 4875.9 836.1 854.6 854.7 856.3 883.3 24053.3 24444.9 24450.0 24462.8 24541.6 805.9 820.2 917.5 948.9 951.7 12617.2 12663.0 12792.0 12888.9 12995.9 686822.0 696463.0 700704.0 702287.0 709164.0 107158.0 107239.0 112620.0 148142.3 149394.0 1207.1 1215.0 1251.1 1252.2 1259.5 20417.6 21910.0 21975.3 22167.4 22222.4 61706.7 62381.0 62507.1 62815.0 63061.4 87914.0 88161.6 88705.7 88857.7 88969.6 12001.8 12605.0 12641.6 12668.6 12731.0 10845.5 11146.8 13987.0 14357.2 14458.3 11497.3 11591.5 11727.4 11729.1 11897.2 10064.0 11469.5 11551.5 11875.5 11962.6 11608.9 11921.1 11924.0 12124.8 12229.6 12797.9 12816.8 13081.3 13126.7 13209.0 10113.7 11747.6 11890.5 11923.4 11932.9 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:6607.31 Median:2363.70 stddev:4096.85 (173.3%) stddev-sans-first:4090.16 10:12:48 INFO - PID 1636 | Values: 1470.5 1517.2 1530.7 1550.4 1580.7 9222.6 9607.3 10433.6 10813.4 10897.3 10109.6 10733.5 10754.8 10788.7 10932.1 2308.9 2362.2 2365.2 2366.9 2367.0 2313.5 2340.7 2351.6 2352.2 2352.8 2285.6 2310.2 2323.7 2328.6 2328.9 2280.7 2289.4 2299.6 2301.4 2307.8 2234.1 2258.3 2266.4 2276.1 2299.0 10908.0 10986.2 10996.0 11023.8 11028.2 5224.9 5404.6 5412.3 5418.0 5421.6 3288.4 3313.6 3413.1 3588.5 3608.8 1110.6 1147.9 1183.9 1223.3 1225.1 13067.8 13942.8 15263.6 15294.0 15467.1 4659.8 4794.3 4808.8 4901.9 4930.5 10501.8 12638.9 12652.1 12658.4 12680.2 4929.4 5837.9 5852.6 5871.7 5885.4 4386.6 4826.2 5037.3 5129.6 5196.4 3924.7 4003.5 4058.7 4090.1 4092.0 1132.0 1136.0 1136.3 1147.8 1169.7 783.2 949.4 960.2 961.9 997.2 6329.6 6448.2 6608.7 6621.2 6683.2 899.7 1023.7 1061.9 1074.8 1076.8 4141.3 4239.3 4249.4 4360.3 4375.7 13209.6 13558.7 13625.2 13673.7 13813.3 11825.8 12645.4 13547.1 13566.8 13605.2 8859.6 9138.9 10001.3 10019.8 10034.3 6536.6 6622.9 6832.8 6868.2 6884.9 11638.7 11762.9 11809.5 11920.5 11937.5 11491.7 11853.7 11990.8 12036.4 12052.1 7804.8 8249.5 8756.5 9208.4 9309.5 9957.9 10101.2 10191.2 10208.7 10239.3 8811.6 8865.2 8870.0 8989.3 9011.9 8008.8 8205.3 8721.3 8815.3 8831.8 7769.7 7792.8 7864.2 7880.4 7881.5 5920.0 5946.1 5981.9 6003.5 6016.8 5935.2 5954.8 5999.0 6073.8 6083.7 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5500.37 Median:5997.40 stddev:1597.06 (26.6%) stddev-sans-first:1554.10 10:12:48 INFO - PID 1636 | Values: 352.8 377.2 378.4 387.3 394.7 6150.9 6162.6 6237.5 6293.0 6328.9 5278.4 6034.5 6143.7 6194.3 6207.6 4097.4 4377.7 4879.6 5024.2 5101.5 4726.0 4772.4 5056.6 5122.8 5129.4 5067.1 5102.5 5113.4 5117.9 5122.8 3960.0 4300.8 4879.3 5060.1 5079.8 4527.3 4587.2 4593.4 4603.2 4615.7 5052.6 5212.8 5306.8 5598.6 6080.1 4351.8 5570.3 5592.0 5727.7 5835.0 5908.9 6639.7 6654.0 6672.6 6713.5 4013.0 4615.2 4782.5 4970.9 5020.7 6043.8 6238.4 6637.7 6735.6 7003.9 5286.0 5306.8 5319.2 5360.9 5379.2 5402.4 5419.4 5423.8 5437.5 5446.0 4412.9 4606.4 4921.9 5595.9 5876.9 6652.2 6660.7 6674.4 6680.2 6689.7 1641.9 1766.3 1851.7 1854.9 1866.2 1146.5 1234.6 1337.0 1346.9 1367.3 5474.3 6237.2 6248.5 6265.4 6325.3 6537.9 6885.3 6890.2 6923.5 6937.6 5960.3 6202.4 6205.7 6260.2 6264.9 3580.2 3608.0 3618.6 3620.7 3621.3 6823.3 7119.3 7168.5 7183.2 7204.7 5452.9 7105.6 7150.7 7198.6 7200.5 6234.7 6534.8 7155.5 7159.9 7201.0 5440.4 6552.5 6885.8 6969.9 6985.2 5004.5 5499.4 5517.5 6188.6 6590.3 6780.4 7059.6 7134.8 7136.4 7150.6 5135.7 5259.4 5358.4 5365.7 5386.7 5610.8 5950.5 6891.1 6904.4 6946.8 6335.4 6466.3 6651.7 6684.7 6687.8 6557.8 6590.2 6643.9 6666.2 6701.3 6493.9 6526.9 6527.0 6527.5 6535.7 6396.1 6659.5 6665.0 6669.3 6725.3 5421.8 6044.2 6566.2 6579.7 6593.8 10:12:48 INFO - PID 1636 | 10:12:48 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:19502.46 Median:3258.91 stddev:27029.79 (829.4%) stddev-sans-first:27068.61 10:12:48 INFO - PID 1636 | Values: 666.5 700.3 713.4 808.6 815.9 14866.5 14920.9 15501.5 15625.5 15708.9 11774.9 14626.8 14720.8 14950.3 15008.9 932.1 966.5 967.1 967.4 969.4 941.7 953.0 953.3 981.4 987.4 1025.5 1029.4 1032.2 1032.8 1036.8 1008.9 1027.2 1028.2 1029.4 1029.8 753.2 765.2 765.3 765.6 765.9 16091.7 16466.8 16547.9 16802.5 16943.6 14556.4 14741.3 14776.6 14871.8 14887.2 11624.0 11651.3 11731.8 11919.7 12016.5 3267.2 3685.2 3701.8 3722.1 3853.3 73109.0 113056.4 113856.0 114836.4 115645.0 11299.3 11324.7 11486.4 11816.9 11876.5 22873.9 24963.9 25213.2 25227.7 25341.9 7899.4 7929.4 7971.6 8063.9 8200.6 4252.8 4271.8 4375.6 4423.0 4435.9 3250.6 3310.0 3535.5 3563.5 3565.6 614.5 619.7 625.8 625.9 639.4 561.4 598.7 604.8 628.7 632.6 9936.0 10116.7 10258.9 10271.6 10480.0 649.4 680.4 692.8 694.2 694.4 4509.4 4901.3 4910.9 4994.5 5005.3 52726.7 72575.9 75444.6 87892.0 96582.5 78690.0 80287.0 81239.2 83449.0 83753.0 72691.9 72899.3 74473.0 75726.2 76065.2 10452.9 10808.5 10851.2 10873.3 11026.9 45144.5 45753.5 45781.1 48301.3 48821.5 66317.0 66507.7 66640.3 67669.7 68353.7 13414.3 13498.3 13597.0 13791.7 13911.4 14425.6 14555.4 14704.6 14707.6 15188.4 10864.8 11344.9 13614.7 14092.5 14281.6 11256.2 11609.0 11903.8 12103.5 12193.7 13155.0 13290.8 13531.6 13587.4 14370.1 11056.9 11057.2 11257.0 11266.3 11427.1 7965.6 9251.8 9274.8 10864.3 11322.9 10:12:48 INFO - PID 1636 | -------- Summary: end -------- 10:12:48 INFO - PID 1636 | 10:12:49 INFO - TEST-INFO | 1636: exit 0 10:12:49 INFO - TEST-OK | dromaeo_css | took 1117051ms 10:12:49 INFO - TEST-START | kraken 10:12:49 INFO - operating with platform_type : mac_ 10:12:49 INFO - Initialising browser for kraken test... 10:12:49 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpos8dCW/profile http://localhost:49241/getInfo.html) 10:12:52 INFO - PID 1647 | 2017-03-14 10:12:52.141 plugin-container[1648:10004] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 10:12:52 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:12:52 INFO - PID 1647 | 2017-03-14 10:12:52.146 plugin-container[1648:10004] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:12:52 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:12:52 INFO - PID 1647 | 2017-03-14 10:12:52.147 plugin-container[1648:10004] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:12:52 INFO - PID 1647 | __metrics Screen width/height:1600/1200 10:12:52 INFO - PID 1647 | colorDepth:24 10:12:52 INFO - PID 1647 | Browser inner width/height: 1024/689 10:12:52 INFO - PID 1647 | __metrics 10:12:52 ERROR - PID 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 10:12:52 INFO - TEST-INFO | 1647: exit 0 10:12:52 INFO - Browser initialized. 10:12:52 INFO - Running cycle 1/1 for kraken test... 10:12:52 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpos8dCW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:55 INFO - PID 1649 | 2017-03-14 10:12:55.427 plugin-container[1650:10128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 10:12:55 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:12:55 INFO - PID 1649 | 2017-03-14 10:12:55.429 plugin-container[1650:10128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 10:12:55 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:12:55 INFO - PID 1649 | 2017-03-14 10:12:55.429 plugin-container[1650:10128] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:13:05 INFO - PID 1649 | RSS: Main: 227680256 10:13:05 INFO - PID 1649 | 10:13:08 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:13:09 INFO - PID 1649 | RSS: Main: 241717248 10:13:09 INFO - PID 1649 | 10:13:11 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:13:12 INFO - PID 1649 | RSS: Main: 249847808 10:13:12 INFO - PID 1649 | 10:13:15 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:13:16 INFO - PID 1649 | RSS: Main: 252424192 10:13:16 INFO - PID 1649 | 10:13:18 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:13:19 INFO - PID 1649 | RSS: Main: 253935616 10:13:19 INFO - PID 1649 | 10:13:21 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:13:21 INFO - PID 1649 | RSS: Main: 254263296 10:13:21 INFO - PID 1649 | 10:13:25 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:13:25 INFO - PID 1649 | RSS: Main: 261066752 10:13:25 INFO - PID 1649 | 10:13:28 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:13:29 INFO - PID 1649 | RSS: Main: 261947392 10:13:29 INFO - PID 1649 | 10:13:32 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:13:33 INFO - PID 1649 | RSS: Main: 262029312 10:13:33 INFO - PID 1649 | 10:13:35 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:13:35 INFO - PID 1649 | RSS: Main: 260894720 10:13:35 INFO - PID 1649 | 10:13:37 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:13:38 INFO - PID 1649 | RSS: Main: 260870144 10:13:38 INFO - PID 1649 | 10:13:40 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:13:41 INFO - PID 1649 | RSS: Main: 261009408 10:13:41 INFO - PID 1649 | 10:13:44 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:13:45 INFO - PID 1649 | RSS: Main: 261566464 10:13:45 INFO - PID 1649 | 10:13:48 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:13:48 INFO - PID 1649 | RSS: Main: 261025792 10:13:48 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:13:50 INFO - PID 1649 | RSS: Main: 264069120 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | __start_tp_report 10:13:50 INFO - PID 1649 | _x_x_mozilla_page_load 10:13:50 INFO - PID 1649 | _x_x_mozilla_page_load_details 10:13:50 INFO - PID 1649 | |i|pagename|runs| 10:13:50 INFO - PID 1649 | |0;ai-astar;115;180;161;123;121;120;120;119;123;132 10:13:50 INFO - PID 1649 | |1;audio-beat-detection;146;116;114;180;116;129;112;119;174;148 10:13:50 INFO - PID 1649 | |2;audio-dft;205;218;211;218;198;195;196;194;197;195 10:13:50 INFO - PID 1649 | |3;audio-fft;70;77;49;94;84;86;54;80;103;88 10:13:50 INFO - PID 1649 | |4;audio-oscillator;85;70;82;72;71;73;83;70;72;84 10:13:50 INFO - PID 1649 | |5;imaging-gaussian-blur;126;136;133;133;91;113;110;137;130;90 10:13:50 INFO - PID 1649 | |6;imaging-darkroom;96;99;103;155;108;153;148;98;97;98 10:13:50 INFO - PID 1649 | |7;imaging-desaturate;146;144;93;93;91;110;146;100;94;92 10:13:50 INFO - PID 1649 | |8;json-parse-financial;67;64;66;67;84;87;67;66;69;67 10:13:50 INFO - PID 1649 | |9;json-stringify-tinderbox;57;61;57;75;94;49;50;66;71;86 10:13:50 INFO - PID 1649 | |10;stanford-crypto-aes;84;84;85;81;85;93;88;108;105;106 10:13:50 INFO - PID 1649 | |11;stanford-crypto-ccm;142;145;164;151;160;149;152;154;209;163 10:13:50 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;186;191;188;188;184;186;190;177;165;238 10:13:50 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;71;68;70;70;70;84;94;99;76;59 10:13:50 INFO - PID 1649 | __end_tp_report 10:13:50 INFO - PID 1649 | __start_cc_report 10:13:50 INFO - PID 1649 | _x_x_mozilla_cycle_collect,994 10:13:50 INFO - PID 1649 | __end_cc_report 10:13:50 INFO - PID 1649 | __startTimestamp1489511630872__endTimestamp 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | ------- Summary: start ------- 10:13:50 INFO - PID 1649 | Number of tests: 14 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:131.40 Median:123.00 stddev:21.53 (17.5%) stddev-sans-first:22.00 10:13:50 INFO - PID 1649 | Values: 115.0 180.0 161.0 123.0 121.0 120.0 120.0 119.0 123.0 132.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:137.50 stddev:25.43 (18.5%) stddev-sans-first:26.68 10:13:50 INFO - PID 1649 | Values: 146.0 116.0 114.0 180.0 116.0 129.0 112.0 119.0 174.0 148.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:202.70 Median:201.50 stddev:9.64 (4.8%) stddev-sans-first:10.19 10:13:50 INFO - PID 1649 | Values: 205.0 218.0 211.0 218.0 198.0 195.0 196.0 194.0 197.0 195.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:78.50 Median:82.00 stddev:16.88 (20.6%) stddev-sans-first:17.62 10:13:50 INFO - PID 1649 | Values: 70.0 77.0 49.0 94.0 84.0 86.0 54.0 80.0 103.0 88.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.50 stddev:6.39 (8.2%) stddev-sans-first:5.93 10:13:50 INFO - PID 1649 | Values: 85.0 70.0 82.0 72.0 71.0 73.0 83.0 70.0 72.0 84.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:119.90 Median:134.50 stddev:17.98 (13.4%) stddev-sans-first:18.93 10:13:50 INFO - PID 1649 | Values: 126.0 136.0 133.0 133.0 91.0 113.0 110.0 137.0 130.0 90.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:96.50 stddev:25.48 (26.4%) stddev-sans-first:26.03 10:13:50 INFO - PID 1649 | Values: 96.0 99.0 103.0 155.0 108.0 153.0 148.0 98.0 97.0 98.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:110.90 Median:91.50 stddev:24.40 (26.7%) stddev-sans-first:22.33 10:13:50 INFO - PID 1649 | Values: 146.0 144.0 93.0 93.0 91.0 110.0 146.0 100.0 94.0 92.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:70.40 Median:67.00 stddev:8.09 (12.1%) stddev-sans-first:8.48 10:13:50 INFO - PID 1649 | Values: 67.0 64.0 66.0 67.0 84.0 87.0 67.0 66.0 69.0 67.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:68.50 stddev:14.98 (21.9%) stddev-sans-first:15.48 10:13:50 INFO - PID 1649 | Values: 57.0 61.0 57.0 75.0 94.0 49.0 50.0 66.0 71.0 86.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.50 stddev:10.46 (12.4%) stddev-sans-first:10.70 10:13:50 INFO - PID 1649 | Values: 84.0 84.0 85.0 81.0 85.0 93.0 88.0 108.0 105.0 106.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:158.90 Median:157.00 stddev:19.05 (12.1%) stddev-sans-first:19.19 10:13:50 INFO - PID 1649 | Values: 142.0 145.0 164.0 151.0 160.0 149.0 152.0 154.0 209.0 163.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:188.00 stddev:18.77 (10.0%) stddev-sans-first:19.87 10:13:50 INFO - PID 1649 | Values: 186.0 191.0 188.0 188.0 184.0 186.0 190.0 177.0 165.0 238.0 10:13:50 INFO - PID 1649 | 10:13:50 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:73.50 stddev:12.49 (17.0%) stddev-sans-first:13.11 10:13:50 INFO - PID 1649 | Values: 71.0 68.0 70.0 70.0 70.0 84.0 94.0 99.0 76.0 59.0 10:13:50 INFO - PID 1649 | -------- Summary: end -------- 10:13:50 INFO - PID 1649 | 10:13:51 INFO - TEST-INFO | 1649: exit 0 10:13:51 INFO - TEST-OK | kraken | took 62346ms 10:13:51 INFO - SUITE-END | took 1179s 10:13:52 INFO - Completed test suite (00:19:39) 10:13:52 INFO - javascript benchmark 10:13:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7987.562449975751, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.935771195506, 3369.174552234703, 3381.8985430437097, 3432.708219801318, 3457.135716070982, 4536.500984891659, 5927.585069045158, 6000.919834429801, 6006.189164462796, 6095.268567771863, 5916.3787802280785, 5986.521078313735, 6004.639721616706, 6080.027195648697, 6103.755849766004, 5358.115910874701, 5395.947790180916, 5402.9729851350685, 5459.153831156157, 5511.807086751965, 4869.948674784778, 5416.83749487516, 5511.751971161308, 5531.2809334786425, 5578.748956296956, 5340.572754179656, 5383.784648614051, 5448.863778405532, 5461.972690136564, 5493.450654934514, 4410.691251612388, 5381.569474442074, 5390.380106287748, 5415.1335786274, 5447.918281225785, 5330.040592693314, 5368.463153684639, 5368.973155134238, 5389.380221274564, 5393.622446428752, 5818.941810581882, 5866.794662186846, 5867.70661466925, 5895.086261629454, 5995.940040599626, 5759.107338362561, 6064.666443345614, 6291.02489114188, 6339.302676705559, 6357.682115894233, 6403.551751377406, 6436.3241859605005, 6437.710303036328, 6445.581037232565, 6448.709808058648, 6132.202813634288, 6141.293751218623, 6153.784617538454, 6159.6612186330185, 6165.599236049642, 6307.274663413675, 6373.681315934185, 6473.676316184172, 6499.642519661369, 6503.8699226015215, 4955.677880937799, 6096.466212027279, 6117.675163990694, 6187.81436556895, 6250.562460627803, 5331.413544510101, 6287.937120628735, 6299.149614802035, 6333.303336632966, 6395.0, 6076.754265375587, 6268.279147897959, 6339.207599050119, 6348.460380867586, 6366.681665916685, 5170.870728231825, 5938.940610593839, 6304.527160462983, 6306.274778400542, 6331.335209802996, 3654.5747158608165, 4296.312589985588, 5041.0422019816115, 5073.568746656501, 5151.2530683050745, 4647.0, 4651.883702907455, 4653.371794807726, 4659.697119687209, 4673.112108699404, 6104.053871649901, 6106.1146133811235, 6127.111568822495, 6128.754849805958, 6136.23297087864, 6238.157848690369, 6297.0, 6449.871002579922, 6493.123428337209, 6497.0, 6033.3061697905305, 6082.908756368658, 6110.694465276719, 6133.969330153321, 6140.969295153495, 5703.458171473703, 5717.742701578439, 5723.971380143156, 5724.942750572441, 5750.022496175577, 6396.296407395276, 6563.212414510289, 6574.441172500391, 6642.036904648896, 6653.800385988428, 5736.827895163152, 5772.81657260269, 6185.41238582334, 6380.776672816429, 6465.2564955030775, 6573.375529324707, 6586.110875032001, 6634.203895532374, 6642.933570664425, 6652.434543063894, 6248.781292654735, 6309.684515774101, 6336.714847831767, 6337.112804207322, 6347.746090156526, 6188.319284878569, 6251.68741562911, 6367.681615919093, 6415.326390729093, 6425.839354016, 6126.509879209563, 6176.845578860564, 6203.2245969253845, 6249.843753906189, 6251.9687401562705, 6108.584917381041, 6147.108669242845, 6221.502279817694, 6238.376162383725, 6249.750009999549, 6041.69791510414, 6103.694815259308, 6143.600665956698, 6214.564980451506, 6220.098085777628, 6152.323244443197, 6200.658963757037, 6222.844428889314, 6259.06114082873, 6259.186305780219, 6137.8060289514, 6160.7535698571555, 6221.5333849960525, 6229.750809967551, 6234.0], "value": 5830.541983867023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9858002839943, 772.3396495995923, 792.144483957326, 919.9908000919997, 929.2380248196481, 30468.476576171186, 37035.0, 37597.060073498105, 37659.0, 37669.62330376699, 36288.455673164855, 36379.4543081854, 37295.0, 37362.0, 37460.81269593655, 7621.0, 7820.687172513092, 10514.579416823357, 10810.837837432446, 10834.891651083506, 10673.78652426951, 10760.461976901162, 10823.404712740796, 10825.133989280877, 10834.891651083506, 9369.718908432758, 10775.784484310308, 10878.782424351548, 11003.889961100367, 11027.117830573536, 10896.073833724144, 10903.672889813319, 10948.343099413982, 10961.232713710044, 10963.232573719843, 10728.195385346053, 10805.351678899291, 10813.405262710548, 10837.566497340096, 10841.186910981707, 37471.81264093689, 37635.62364376349, 37682.62317376819, 37707.43438848392, 37881.0529736756, 3862.1117143057254, 3871.8838434847, 3900.3759398496386, 3932.5477570079233, 4034.3141665916864, 27755.0, 27778.305542361402, 27834.3041423964, 27914.0, 27942.301442463897, 3102.1158969693756, 3115.8597863096215, 3229.031290612807, 3235.9420347771365, 3241.9625719769683, 323250.0, 324294.0, 325108.0, 325272.0, 325291.0, 49623.007539849, 49781.0043799122, 49908.50091499111, 50084.74788130326, 50088.0, 51455.97088058218, 51508.484915151115, 51525.0, 51554.48445515572, 51575.484245157815, 14657.267136643126, 14694.485693000694, 14744.63138421548, 14845.92577037108, 14927.552173434815, 11913.58302459427, 11970.640880773592, 11981.221220620631, 12003.51985920571, 12014.939925300318, 11202.94398528002, 13754.518591849237, 13777.448902044007, 13784.517541885985, 13873.445062197601, 4971.776270067856, 5855.180274761537, 5915.615484993462, 5922.615030023035, 5953.553483488669, 1144.690933447981, 1145.3986657004973, 1147.6958605969426, 1154.717094311899, 1197.9161458697808, 22554.21060262916, 26166.86916565405, 26262.395080278886, 26486.337841554116, 26505.46989060208, 1169.3101070368523, 1240.1504969096197, 1253.5487224599137, 1296.5786119511197, 1302.257713103541, 13514.662133446742, 15336.0, 15516.689666206612, 15557.22213889301, 15872.841271587136, 425184.0, 427819.0, 430098.0, 430145.0, 430643.0, 58254.12618810721, 58793.0, 58831.411685882595, 58925.41074589285, 59113.0, 1227.6562562482698, 1375.9931200343933, 1423.8149040624653, 1427.835798883121, 1443.4659176104908, 18837.80830471448, 28180.85909570521, 29135.125946221648, 29199.416011679223, 30501.54247686242, 52858.67853303698, 53041.20438193507, 53306.933861323334, 53363.733181333846, 53390.46609533855, 443726.0, 445295.7735211303, 448090.0, 448501.0, 449810.0, 32951.835240823646, 33228.50157247595, 33945.830270848484, 33949.83025084859, 34038.65961340355, 41637.79181104075, 42125.0, 42343.0, 42409.78795106005, 42583.36124958066, 34035.48946765751, 34163.31673366469, 34234.0, 35092.298154037286, 35142.64857351496, 26819.86590067037, 35094.473582895764, 35165.0, 36119.0, 36709.08227294339, 35375.938721838385, 35935.64064359428, 35955.101122472144, 36020.81989590035, 36306.27387452289, 30288.788448462696, 31811.36377272488, 31814.52278215875, 31832.5225121628, 32044.51933220957, 21084.31325493926, 22460.887695561418, 22741.09035638622, 23702.407439814142, 24768.752312476645], "value": 19028.75974747302, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.8021088401379, 396.136422598735, 403.3647005965605, 408.6016134269087, 422.9767362795045, 19869.701954470693, 21549.353519394423, 21715.02282397292, 22213.444663883412, 22244.443888902784, 19690.310839120633, 20502.17991280351, 21128.788712112873, 22361.10555577779, 22530.0, 6200.937990620104, 6318.589291696048, 6859.176898772154, 6877.931220687804, 6913.1358580177475, 6704.73181072759, 6828.556143850658, 7459.104907411118, 7815.2966233039015, 7879.4484386093, 7720.459567830254, 7857.057153141603, 7858.410619203554, 7864.960675196616, 7876.448648594601, 7558.62206889656, 7796.376289896852, 7810.882836757425, 7825.569593672346, 7858.214178582153, 6786.966065169692, 7323.121225452926, 7607.695692172307, 7672.079350477922, 7727.49771264866, 27534.724652753415, 29168.124956251348, 29836.0, 29900.85049574738, 30191.698083019328, 3384.4077286474767, 3392.8473218705217, 3454.5336379588684, 3456.6888979991922, 3564.144605294711, 16613.335466581324, 16872.91563542187, 16952.49142525714, 17087.316507339692, 17460.30158793647, 2040.2553068130026, 2046.549759053006, 2050.9487262818398, 2054.209129485144, 2057.989710051455, 107088.85822283589, 138672.0, 140139.0, 140145.0, 143764.0, 18950.0, 19967.800321996885, 24196.790160491906, 25914.740852591232, 26278.73721262801, 41443.37834932478, 42002.0, 42279.577204227564, 42364.94087647834, 42469.0, 11189.160812939062, 11325.546978120949, 11359.48882300282, 11538.423078846025, 11592.536298547964, 8866.822663546693, 8906.0, 8948.970868350223, 9102.226310763659, 9111.997680255166, 9819.312648114563, 11875.228110172811, 12098.395080245953, 12219.633410997685, 12389.93805030969, 4008.599140085968, 4722.291656251521, 4799.752064463265, 4853.466118726938, 4875.926861097087, 836.1011912194415, 854.645322191296, 854.7307598106577, 856.3063918226256, 883.3021912688904, 24053.278401647978, 24444.899979500966, 24450.0, 24462.755372446405, 24541.63187552188, 805.9314958228616, 820.2330820682681, 917.499962520428, 948.9193418559499, 951.7477868364889, 12617.179883307555, 12663.0, 12792.0, 12888.935555322163, 12995.870041299466, 686822.0, 696463.0, 700704.0, 702287.0, 709164.0, 107158.0, 107239.0, 112620.0, 148142.259288705, 149394.0, 1207.106741011645, 1214.9635510934686, 1251.1117106854053, 1252.2111070025826, 1259.5024965138903, 20417.59164816725, 21910.0, 21975.34073977719, 22167.44581385478, 22222.444438889157, 61706.69146654417, 62381.0, 62507.06239406503, 62815.0, 63061.36938630555, 87914.0, 88161.55919220363, 88705.66941496012, 88857.66713499432, 88969.55515222382, 12001.75996480048, 12605.0, 12641.557545485864, 12668.556600518938, 12730.96304591261, 10845.457727113455, 11146.832797508207, 13987.0, 14357.21035343066, 14458.349374277972, 11497.252678575866, 11591.478383472933, 11727.41362931833, 11729.120315976506, 11897.167198296036, 10063.993600639877, 11469.541218351505, 11551.537938482703, 11875.465604048011, 11962.641120766391, 11608.88391116078, 11921.105917056082, 11923.9864611509, 12124.75750485003, 12229.633111006684, 12797.936010319889, 12816.807747883602, 13081.345932703518, 13126.737465250451, 13209.0, 10113.747156321151, 11747.588834391097, 11890.524379024742, 11923.403829808649, 11932.940335298268], "value": 12185.056818483761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.5000299898036, 1517.1958861803248, 1530.724469595473, 1550.356602010166, 1580.7391780356243, 9222.584983675733, 9607.27945404094, 10433.582656693732, 10813.35119892806, 10897.291676041052, 10109.646162384319, 10733.51699173537, 10754.838677419844, 10788.676339709802, 10932.125429965603, 2308.873011984336, 2362.2204672458133, 2365.1721897335965, 2366.8579885206855, 2367.0, 2313.5141620259765, 2340.719113706358, 2351.5884720173985, 2352.188494969241, 2352.764723527651, 2285.565742508918, 2310.2260742651233, 2323.732770731362, 2328.580855446019, 2328.895199716017, 2280.737715162761, 2289.427643089228, 2299.6435552489393, 2301.390131615123, 2307.826912981533, 2234.1175235781775, 2258.3450799268194, 2266.3994041578994, 2276.055436993646, 2298.97701022991, 10908.0, 10986.230963832535, 10996.0, 11023.779524409547, 11028.172887033505, 5224.92162617561, 5404.594655400861, 5412.296401467784, 5418.0, 5421.620486565942, 3288.375208710361, 3313.5858017747782, 3413.0784688134063, 3588.4617307404096, 3608.783472991629, 1110.5946329589722, 1147.8966892979588, 1183.9171258011943, 1223.3027174510532, 1225.1424003197797, 13067.803982940264, 13942.790858137034, 15263.618409539738, 15294.0, 15467.149306788122, 4659.828609611371, 4794.2808578713475, 4808.783604737725, 4901.901961960741, 4930.457649658535, 10501.842472362921, 12638.873611263769, 12652.051096167825, 12658.367081645882, 12680.175788573713, 4929.408470983433, 5837.88324233513, 5852.648841069549, 5871.735771890275, 5885.411458854081, 4386.561343865588, 4826.203676393426, 5037.345145131109, 5129.615278854101, 5196.350456192976, 3924.7056470764805, 4003.499562554681, 4058.6955978301744, 4090.0592863640936, 4092.0383709828166, 1131.9830202546968, 1136.0343707848263, 1136.3409222650844, 1147.75897061618, 1169.7017260598493, 783.1815752538611, 949.4018768176005, 960.2270172511056, 961.9230461563059, 997.1972562087444, 6329.620222786648, 6448.161738973903, 6608.7356505739235, 6621.238557565845, 6683.164604424447, 899.6896070855545, 1023.7491814505345, 1061.9256652034437, 1074.8280275155937, 1076.7738774857369, 4141.316682747313, 4239.300515414983, 4249.447571815645, 4360.2587560114225, 4375.693701440869, 13209.603711888658, 13558.661033474045, 13625.18248905049, 13673.658158545917, 13813.309334533233, 11825.822612660817, 12645.43095560702, 13547.119437236548, 13566.796498052538, 13605.183688978694, 8859.601317940707, 9138.862917056249, 10001.299909006446, 10019.79960400788, 10034.347767395097, 6536.640484773383, 6622.90065649006, 6832.795016149524, 6868.175818901564, 6884.8967265490055, 11638.70903227426, 11762.94118529402, 11809.527618895492, 11920.463579139134, 11937.46281417321, 11491.655250342503, 11853.703657408634, 11990.820137698116, 12036.398180091135, 12052.09609279325, 7804.765857024298, 8249.546274954935, 8756.51839148853, 9208.355415120877, 9309.487978161265, 9957.850632240667, 10101.191904647758, 10191.184705223712, 10208.744781380525, 10239.334443261165, 8811.60347784364, 8865.24645405122, 8869.955650221707, 8989.325800565115, 9011.909880901107, 8008.758642410436, 8205.261526462407, 8721.302295816446, 8815.338849586178, 8831.779205519913, 7769.6892124316655, 7792.84414311722, 7864.1742617026675, 7880.369570434466, 7881.487703299267, 5920.0, 5946.13781001761, 5981.850453738692, 6003.519718422603, 6016.789412370546, 5935.228420305332, 5954.76180952757, 5999.0, 6073.817785466443, 6083.726232319645], "value": 5068.615162491927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.80595672380184, 377.2040993503708, 378.40968089779943, 387.25840016368636, 394.7256656623647, 6150.938490615093, 6162.568620196583, 6237.46981506572, 6292.9685351573235, 6328.905066424008, 5278.392984806748, 6034.517238620911, 6143.723532441039, 6194.287656919456, 6207.627542347463, 4097.364908439182, 4377.6716746244, 4879.585235255007, 5024.171011783052, 5101.464346243656, 4726.0, 4772.3968403855215, 5056.595472362221, 5122.8207012754565, 5129.358830146231, 5067.113255180348, 5102.540771330579, 5113.43752187261, 5117.872053198663, 5122.820701275437, 3960.0, 4300.784960751966, 4879.341288926003, 5060.139776238048, 5079.8222062228015, 4527.253003254459, 4587.197240482902, 4593.425821772278, 4603.194440972849, 4615.723056616614, 5052.621053420971, 5212.774997875496, 5306.787728490855, 5598.552115830765, 6080.05438259757, 4351.843988990507, 5570.3315602128005, 5591.9720401398135, 5727.713614319309, 5835.024137689767, 5908.852278693067, 6639.73441062357, 6654.0, 6672.599644021374, 6713.4964877634375, 4012.979935100335, 4615.169269531517, 4782.473927867932, 4970.906400591864, 5020.6946193989825, 6043.848903777397, 6238.438540531374, 6637.7013034413085, 6735.595864248161, 7003.92996070043, 5285.9735701322015, 5306.8407947761625, 5319.164873137999, 5360.946390536123, 5379.246905433164, 5402.405735369106, 5419.403865574784, 5423.810166644149, 5437.483439073281, 5445.992491389026, 4412.911741765147, 4606.424196975378, 4921.892574170783, 5595.860103497445, 5876.883392155477, 6652.168478940132, 6660.70026848793, 6674.432673222734, 6680.229739119137, 6689.6989635466525, 1641.9014859108493, 1766.275826910986, 1851.7407562941198, 1854.8608854335978, 1866.188208129468, 1146.512732088859, 1234.5617305856472, 1337.037333120152, 1346.8518462969066, 1367.3300082959279, 5474.2609747683555, 6237.1891654084675, 6248.50011999039, 6265.4361107500545, 6325.335839736854, 6537.934620653733, 6885.311468853175, 6890.2420733719255, 6923.515353925278, 6937.618430986243, 5960.284765828042, 6202.41077097675, 6205.689715514206, 6260.24877014752, 6264.9373506265265, 3580.230250496156, 3607.981960090183, 3618.5706645874734, 3620.7189470633857, 3621.293847699726, 6823.283555226729, 7119.288071192839, 7168.498205125696, 7183.209846916835, 7204.747833825791, 5452.945470545323, 7105.609191494517, 7150.713971441188, 7198.604076775723, 7200.495965282485, 6234.657093859882, 6534.758395904762, 7155.463340249502, 7159.89260161098, 7201.0, 5440.428754980829, 6552.508561857975, 6885.827854303682, 6969.930300697131, 6985.231624521197, 5004.47453017428, 5499.395066542757, 5517.531009864046, 6188.566800323934, 6590.308017658269, 6780.355866192704, 7059.611721355374, 7134.821629459305, 7136.395215746319, 7150.570965741864, 5135.6918584885025, 5259.368875734936, 5358.35699716021, 5365.651232669864, 5386.730663466889, 5610.831675049755, 5950.464458198783, 6891.069705589882, 6904.447644188353, 6946.826329341807, 6335.3981371769605, 6466.32103629131, 6651.667416629246, 6684.665766711548, 6687.8328041797395, 6557.836054098686, 6590.209174899042, 6643.900341494785, 6666.166729158856, 6701.32986701326, 6493.935060649333, 6526.902096468461, 6526.967365163144, 6527.51043671717, 6535.705893234911, 6396.136521569529, 6659.467242620675, 6665.0, 6669.266380698216, 6725.260221375743, 5421.83734487966, 6044.214252147192, 6566.244881838458, 6579.671016449062, 6593.80218593443], "value": 5011.827766462823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.5034549260798, 700.3346820520507, 713.414999700246, 808.6037841457686, 815.9224873637005, 14866.47967321144, 14920.850791492081, 15501.534953951399, 15625.453109141183, 15708.921455392721, 11774.941125294361, 14626.780598291034, 14720.779188312184, 14950.252487375643, 15008.924955375207, 932.1470854168427, 966.5119114846992, 967.0909345215475, 967.3567077893227, 969.3941286695815, 941.6610020392653, 952.9904700952972, 953.2516974175273, 981.3915372469079, 987.3680844259679, 1025.5077562769875, 1029.4183786160795, 1032.230987914005, 1032.7573020340214, 1036.7978244242377, 1008.9495525223709, 1027.1885210683552, 1028.1825948371027, 1029.377226777796, 1029.7991891581144, 753.1677496366491, 765.1774342581691, 765.3226894198618, 765.6133652505449, 765.9157492675802, 16091.678166436723, 16466.75299870503, 16547.917260413622, 16802.495925122264, 16943.57641058971, 14556.417743290256, 14741.336639851232, 14776.556703298918, 14871.776923346159, 14887.18120503372, 11624.0, 11651.300921944625, 11731.824022639667, 11919.702007449796, 12016.519339226508, 3267.232200432896, 3685.1892583631557, 3701.833417496219, 3722.143906901401, 3853.3064048471265, 73109.0, 113056.43471782589, 113856.0, 114836.4258178712, 115645.0, 11299.265547739371, 11324.716882078013, 11486.368249746343, 11816.940915295541, 11876.465559049864, 22873.88563057174, 24963.87518062398, 25213.24360269195, 25227.74772252291, 25341.87329063343, 7899.407544434191, 7929.365650747926, 7971.601419929097, 8063.879041814377, 8200.58997050157, 4252.808623611945, 4271.829126834954, 4375.628071613948, 4423.0, 4435.933460998088, 3250.593675790526, 3309.983450082734, 3535.487354333607, 3563.465480177994, 3565.607783143852, 614.5176036811082, 619.6560908695627, 625.7841044839523, 625.9311475737666, 639.3766078073841, 561.3659242949426, 598.7096258314714, 604.7641419846263, 628.707650942314, 632.5761739634364, 9935.950320248352, 10116.74708132288, 10258.948705256425, 10271.589136434459, 10480.0, 649.4317472211815, 680.3740558686021, 692.8025512728848, 694.2051351202845, 694.3820000199826, 4509.429625113719, 4901.29474712516, 4910.926336104962, 4994.475580064113, 5005.3242812220615, 52726.73636631792, 72575.91136132962, 75444.62277688576, 87892.0, 96582.51708741412, 78690.0, 80286.99282517984, 81239.18760812434, 83449.0, 83753.0, 72691.90962135572, 72899.26154799921, 74473.0, 75726.24273757302, 76065.23934760582, 10452.895471045496, 10808.513616887101, 10851.240413171003, 10873.293235939638, 11026.889731102907, 45144.54855451403, 45753.54246457626, 45781.08437831158, 48301.27548086852, 48821.53535393944, 66317.0, 66507.66746166238, 66640.33359666535, 67669.66165169142, 68353.6582317105, 13414.262215577846, 13498.257595832323, 13597.0, 13791.724165516835, 13911.373988170355, 14425.639359016108, 14555.41778328855, 14704.632384190481, 14707.632309191928, 15188.392464301303, 10864.837027444753, 11344.943275283571, 13614.727705446034, 14092.506762263682, 14281.64295892611, 11256.228482858034, 11609.0, 11903.761924761284, 12103.455344509342, 12193.69515762113, 13155.0, 13290.807016842113, 13531.59405217845, 13587.388567514288, 14370.13779173253, 11056.944715276371, 11057.22599418033, 11257.0, 11266.324020558794, 11427.085833133164, 7965.641546130554, 9251.76870578241, 9274.768130796783, 10864.251723415557, 11322.94338528302], "value": 7561.652073933333, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 180.0, 161.0, 123.0, 121.0, 120.0, 120.0, 119.0, 123.0, 132.0], "value": 131.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 114.0, 180.0, 116.0, 129.0, 112.0, 119.0, 174.0, 148.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 218.0, 211.0, 218.0, 198.0, 195.0, 196.0, 194.0, 197.0, 195.0], "value": 202.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 49.0, 94.0, 84.0, 86.0, 54.0, 80.0, 103.0, 88.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 82.0, 72.0, 71.0, 73.0, 83.0, 70.0, 72.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 136.0, 133.0, 133.0, 91.0, 113.0, 110.0, 137.0, 130.0, 90.0], "value": 119.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 103.0, 155.0, 108.0, 153.0, 148.0, 98.0, 97.0, 98.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 93.0, 93.0, 91.0, 110.0, 146.0, 100.0, 94.0, 92.0], "value": 110.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 67.0, 84.0, 87.0, 67.0, 66.0, 69.0, 67.0], "value": 70.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 57.0, 75.0, 94.0, 49.0, 50.0, 66.0, 71.0, 86.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 81.0, 85.0, 93.0, 88.0, 108.0, 105.0, 106.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 145.0, 164.0, 151.0, 160.0, 149.0, 152.0, 154.0, 209.0, 163.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 191.0, 188.0, 188.0, 184.0, 186.0, 190.0, 177.0, 165.0, 238.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 70.0, 70.0, 84.0, 94.0, 99.0, 76.0, 59.0], "value": 76.1, "unit": "score"}]}]} 10:13:52 INFO - Return code: 0 10:13:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:13:52 ERROR - # TBPL SUCCESS # 10:13:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:52 INFO - 2017-03-14 10:13:52.175 screenresolution[1654:10511] starting screenresolution argv=screenresolution get 10:13:52 INFO - 2017-03-14 10:13:52.177 screenresolution[1654:10511] Display 0: 1600x1200x32@60 10:13:52 INFO - 2017-03-14 10:13:52.183 screenresolution[1655:10514] starting screenresolution argv=screenresolution list 10:13:52 INFO - Available Modes on Display 0 10:13:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:52 INFO - Intel Iris: 10:13:52 INFO - Chipset Model: Intel Iris 10:13:52 INFO - Type: GPU 10:13:52 INFO - Bus: Built-In 10:13:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:52 INFO - Vendor: Intel (0x8086) 10:13:52 INFO - Device ID: 0x0a2e 10:13:52 INFO - Revision ID: 0x0009 10:13:52 INFO - Displays: 10:13:52 INFO - Display: 10:13:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:52 INFO - Display Serial Number: 1600x1200 60 10:13:52 INFO - Main Display: Yes 10:13:52 INFO - Mirror: Off 10:13:52 INFO - Online: Yes 10:13:52 INFO - Rotation: Supported 10:13:52 INFO - Return code: 0 10:13:52 INFO - Running post-action listener: _resource_record_post_action 10:13:52 INFO - [mozharness: 2017-03-14 17:13:52.409122Z] Finished run-tests step (success) 10:13:52 INFO - Running post-run listener: _resource_record_post_run 10:13:52 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 40532480; Write bytes: 515526656; Read time: 402; Write time: 1735 10:13:52 INFO - TinderboxPrint: CPU usage
54.2% 10:13:52 INFO - TinderboxPrint: I/O read bytes / time
40,532,480 / 402 10:13:52 INFO - TinderboxPrint: I/O write bytes / time
515,526,656 / 1,735 10:13:52 INFO - TinderboxPrint: CPU idle
2,202.9 (45.8%) 10:13:52 INFO - TinderboxPrint: CPU system
967.0 (20.1%) 10:13:52 INFO - TinderboxPrint: CPU user
1,635.8 (34.0%) 10:13:52 INFO - TinderboxPrint: Swap in / out
250,281,984 / 0 10:13:52 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202232320; Write bytes: 202679808; Read time: 15732; Write time: 387 10:13:52 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 39168512; Write bytes: 302930432; Read time: 377; Write time: 1321 10:13:52 INFO - Running post-run listener: _upload_blobber_files 10:13:52 INFO - Blob upload gear active. 10:13:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:13:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:13:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:54 INFO - (blobuploader) - INFO - Done attempting. 10:13:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:13:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:55 INFO - (blobuploader) - INFO - Done attempting. 10:13:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:13:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:13:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:56 INFO - (blobuploader) - INFO - Done attempting. 10:13:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:13:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:13:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:58 INFO - (blobuploader) - INFO - Done attempting. 10:13:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:58 INFO - Return code: 0 10:13:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78e5c81fb3d7f8425ff07a3476c317d7a39677a1c351719210800fead4ef3896109f6c5ca092e164dc9f2b905c2e0d41a3ba66f75bcfcfad0c06ec0b5f67fc2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6906c5522417622efc235cc99da3cdf5f5f5578150e647f8321425052fa883288bd5860a6ae581deb5137ff2e1bcc6995906f52359f5c520148bcb1d5764ad69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5eeb62e6f82feb3776e7fee1c757a27ab31e32e544dc256e547dcd3c5cc68188bb3d664a3b3cdc0f7882ad040db809f6f5ba22376b3f5966a194dc79d04e527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0a2364d684fe81139795c097463936cb23907b1e9ed0793047fc0f4d7f335089659b58839a6e4e717de77e4d2a66bb31de217db2ab44cb0b59bea6139c832c"} 10:13:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:58 INFO - Contents: 10:13:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78e5c81fb3d7f8425ff07a3476c317d7a39677a1c351719210800fead4ef3896109f6c5ca092e164dc9f2b905c2e0d41a3ba66f75bcfcfad0c06ec0b5f67fc2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6906c5522417622efc235cc99da3cdf5f5f5578150e647f8321425052fa883288bd5860a6ae581deb5137ff2e1bcc6995906f52359f5c520148bcb1d5764ad69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5eeb62e6f82feb3776e7fee1c757a27ab31e32e544dc256e547dcd3c5cc68188bb3d664a3b3cdc0f7882ad040db809f6f5ba22376b3f5966a194dc79d04e527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0a2364d684fe81139795c097463936cb23907b1e9ed0793047fc0f4d7f335089659b58839a6e4e717de77e4d2a66bb31de217db2ab44cb0b59bea6139c832c"} 10:13:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:58 INFO - Copying logs to upload dir... 10:13:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.714499 ========= master_lag: 2.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-14 10:14:00.937351) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-14 10:14:00.940503) ========= 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.tPXkZrz2hL/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.jysL54Y6iy/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78e5c81fb3d7f8425ff07a3476c317d7a39677a1c351719210800fead4ef3896109f6c5ca092e164dc9f2b905c2e0d41a3ba66f75bcfcfad0c06ec0b5f67fc2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6906c5522417622efc235cc99da3cdf5f5f5578150e647f8321425052fa883288bd5860a6ae581deb5137ff2e1bcc6995906f52359f5c520148bcb1d5764ad69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5eeb62e6f82feb3776e7fee1c757a27ab31e32e544dc256e547dcd3c5cc68188bb3d664a3b3cdc0f7882ad040db809f6f5ba22376b3f5966a194dc79d04e527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0a2364d684fe81139795c097463936cb23907b1e9ed0793047fc0f4d7f335089659b58839a6e4e717de77e4d2a66bb31de217db2ab44cb0b59bea6139c832c"} build_url:https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011062 build_url: 'https://queue.taskcluster.net/v1/task/GJRfiTFBRaCH3uFACCazXQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d78e5c81fb3d7f8425ff07a3476c317d7a39677a1c351719210800fead4ef3896109f6c5ca092e164dc9f2b905c2e0d41a3ba66f75bcfcfad0c06ec0b5f67fc2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6906c5522417622efc235cc99da3cdf5f5f5578150e647f8321425052fa883288bd5860a6ae581deb5137ff2e1bcc6995906f52359f5c520148bcb1d5764ad69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5eeb62e6f82feb3776e7fee1c757a27ab31e32e544dc256e547dcd3c5cc68188bb3d664a3b3cdc0f7882ad040db809f6f5ba22376b3f5966a194dc79d04e527", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f0a2364d684fe81139795c097463936cb23907b1e9ed0793047fc0f4d7f335089659b58839a6e4e717de77e4d2a66bb31de217db2ab44cb0b59bea6139c832c"}' ========= master_lag: 1.61 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-14 10:14:02.566505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 10:14:02.567019) ========= 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.tPXkZrz2hL/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.jysL54Y6iy/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.005057 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 10:14:02.596699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 10:14:02.597018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 10:14:02.597713) ========= ========= Total master_lag: 4.04 =========