builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0392 starttime: 1493045142.37 results: success (0) buildid: 20170424065420 builduid: 79f062eaf83a4c3d84a370ba439c4f79 revision: 62b649c6b314f756f21cb95f2b0d491e2664e944 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.368275) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.368720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.369010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.396084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.396734) ========= 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.ZxL7mTewQM/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.9mVNkeslqf/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-24 07:45:42-- 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% 18.3M=0.001s 2017-04-24 07:45:43 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.233266 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.659003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.659318) ========= 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.ZxL7mTewQM/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.9mVNkeslqf/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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.027120 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:42.709268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 07:45:42.709625) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 62b649c6b314f756f21cb95f2b0d491e2664e944 --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 62b649c6b314f756f21cb95f2b0d491e2664e944 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZxL7mTewQM/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.9mVNkeslqf/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-24 07:45:43,336 truncating revision to first 12 chars 2017-04-24 07:45:43,336 Setting DEBUG logging. 2017-04-24 07:45:43,336 attempt 1/10 2017-04-24 07:45:43,336 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/62b649c6b314?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 07:45:45,415 unpacking tar archive at: mozilla-central-62b649c6b314/testing/mozharness/ program finished with exit code 0 elapsedTime=2.363977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 07:45:45.097936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:45.098246) ========= script_repo_revision: 62b649c6b314f756f21cb95f2b0d491e2664e944 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:45.098712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:45.099030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 07:45:45.119264) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-24 07:45:45.119632) ========= /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.ZxL7mTewQM/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.9mVNkeslqf/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:45:45 INFO - MultiFileLogger online at 20170424 07:45:45 in /builds/slave/test 07:45:45 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 07:45:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:45 INFO - {'append_to_log': False, 07:45:45 INFO - 'base_work_dir': '/builds/slave/test', 07:45:45 INFO - 'blob_upload_branch': 'Firefox', 07:45:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:45 INFO - 'branch': 'Firefox', 07:45:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:45 INFO - 'config_files': ('talos/mac_config.py',), 07:45:45 INFO - 'default_actions': ('clobber', 07:45:45 INFO - 'read-buildbot-config', 07:45:45 INFO - 'download-and-extract', 07:45:45 INFO - 'populate-webroot', 07:45:45 INFO - 'create-virtualenv', 07:45:45 INFO - 'install', 07:45:45 INFO - 'run-tests'), 07:45:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:45 INFO - 'download_minidump_stackwalk': True, 07:45:45 INFO - 'download_symbols': 'ondemand', 07:45:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:45 INFO - 'gecko_profile': False, 07:45:45 INFO - 'gecko_profile_interval': 0, 07:45:45 INFO - 'installer_path': 'installer.exe', 07:45:45 INFO - 'log_level': 'info', 07:45:45 INFO - 'log_name': 'talos', 07:45:45 INFO - 'log_to_console': True, 07:45:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:45:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:45:45 INFO - 'opt_config_files': (), 07:45:45 INFO - 'pip_index': False, 07:45:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:45 INFO - 'cmd': ('bash', 07:45:45 INFO - '-c', 07:45:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:45 INFO - 'enabled': True, 07:45:45 INFO - 'halt_on_failure': False, 07:45:45 INFO - 'name': 'check_screen_resolution'},), 07:45:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:45 INFO - 'cmd': ('bash', 07:45:45 INFO - '-c', 07:45:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:45 INFO - 'enabled': True, 07:45:45 INFO - 'halt_on_failure': False, 07:45:45 INFO - 'name': 'check_screen_resolution'},), 07:45:45 INFO - 'run_cmd_checks_enabled': True, 07:45:45 INFO - 'suite': 'dromaeojs-e10s', 07:45:45 INFO - 'system_bits': '32', 07:45:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:45 INFO - 'title': 't-yosemite-r7-0392', 07:45:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:45 INFO - 'use_talos_json': True, 07:45:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:45 INFO - 'work_dir': 'build'} 07:45:45 INFO - [mozharness: 2017-04-24 14:45:45.851640Z] Running clobber step. 07:45:45 INFO - Running pre-action listener: _resource_record_pre_action 07:45:45 INFO - Running main action method: clobber 07:45:45 INFO - rmtree: /builds/slave/test/build 07:45:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:45:48 INFO - Running post-action listener: _resource_record_post_action 07:45:48 INFO - [mozharness: 2017-04-24 14:45:48.198283Z] Finished clobber step (success) 07:45:48 INFO - [mozharness: 2017-04-24 14:45:48.198409Z] Running read-buildbot-config step. 07:45:48 INFO - Running pre-action listener: _resource_record_pre_action 07:45:48 INFO - Running main action method: read_buildbot_config 07:45:48 INFO - Using buildbot properties: 07:45:48 INFO - { 07:45:48 INFO - "project": "", 07:45:48 INFO - "product": "firefox", 07:45:48 INFO - "script_repo_revision": "production", 07:45:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:45:48 INFO - "repository": "", 07:45:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:45:48 INFO - "buildid": "20170424065420", 07:45:48 INFO - "pgo_build": "False", 07:45:48 INFO - "basedir": "/builds/slave/test", 07:45:48 INFO - "buildnumber": 39, 07:45:48 INFO - "slavename": "t-yosemite-r7-0392", 07:45:48 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:45:48 INFO - "platform": "yosemite_r7", 07:45:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:45:48 INFO - "branch": "mozilla-central", 07:45:48 INFO - "repo_path": "mozilla-central", 07:45:48 INFO - "revision": "62b649c6b314f756f21cb95f2b0d491e2664e944", 07:45:48 INFO - "stage_platform": "macosx64", 07:45:48 INFO - "builduid": "79f062eaf83a4c3d84a370ba439c4f79", 07:45:48 INFO - "slavebuilddir": "test" 07:45:48 INFO - } 07:45:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 07:45:48 INFO - Running post-action listener: _resource_record_post_action 07:45:48 INFO - [mozharness: 2017-04-24 14:45:48.201849Z] Finished read-buildbot-config step (success) 07:45:48 INFO - [mozharness: 2017-04-24 14:45:48.201969Z] Running download-and-extract step. 07:45:48 INFO - Running pre-action listener: _resource_record_pre_action 07:45:48 INFO - Running main action method: download_and_extract 07:45:48 INFO - mkdir: /builds/slave/test/build/tests 07:45:48 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')]} 07:45:48 INFO - trying https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/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 07:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/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 07:45:49 INFO - Downloaded 1325 bytes. 07:45:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:45:49 INFO - Using the following test package requirements: 07:45:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 07:45:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:45:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:45:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:45:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'jsshell-mac.zip'], 07:45:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:45:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:45:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:45:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:45:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:45:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:45:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:45:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:45:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:45:49 INFO - Fetch https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:45:50 INFO - Content-Length response header: 52522796 07:45:50 INFO - Bytes received: 52522796 07:46:06 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 07:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:46:08 INFO - Content-Length response header: 52522796 07:46:08 INFO - Bytes received: 52522796 07:46:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:46:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:46:24 INFO - Fetch https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:46:25 INFO - Content-Length response header: 14408822 07:46:25 INFO - Bytes received: 14408822 07:46:26 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')]} 07:46:26 INFO - trying https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/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 07:46:28 INFO - Downloaded 71039084 bytes. 07:46:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:28 INFO - mkdir: /builds/slave/test/properties 07:46:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:28 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:28 INFO - Contents: 07:46:28 INFO - build_url:https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:28 INFO - Running post-action listener: _resource_record_post_action 07:46:28 INFO - Running post-action listener: set_extra_try_arguments 07:46:28 INFO - [mozharness: 2017-04-24 14:46:28.821705Z] Finished download-and-extract step (success) 07:46:28 INFO - [mozharness: 2017-04-24 14:46:28.821837Z] Running populate-webroot step. 07:46:28 INFO - Running pre-action listener: _resource_record_pre_action 07:46:28 INFO - Running main action method: populate_webroot 07:46:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:28 INFO - '--tppagecycles', 07:46:28 INFO - '7'], 07:46:28 INFO - 'tests': ['tsvgm']}}, 07:46:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['damp', 'tps']}, 07:46:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'tests': ['damp', 'tps']}, 07:46:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['dromaeo_dom']}, 07:46:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:46:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:46:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['a11yr', 07:46:28 INFO - 'ts_paint', 07:46:28 INFO - 'tpaint', 07:46:28 INFO - 'sessionrestore', 07:46:28 INFO - 'sessionrestore_no_auto_restore', 07:46:28 INFO - 'tabpaint']}, 07:46:28 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:28 INFO - 'ts_paint', 07:46:28 INFO - 'tpaint', 07:46:28 INFO - 'sessionrestore', 07:46:28 INFO - 'sessionrestore_no_auto_restore', 07:46:28 INFO - 'tabpaint']}, 07:46:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:28 INFO - 'ts_paint', 07:46:28 INFO - 'tpaint', 07:46:28 INFO - 'sessionrestore', 07:46:28 INFO - 'sessionrestore_no_auto_restore', 07:46:28 INFO - 'tabpaint']}, 07:46:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:28 INFO - 'ts_paint', 07:46:28 INFO - 'tpaint', 07:46:28 INFO - 'sessionrestore', 07:46:28 INFO - 'sessionrestore_no_auto_restore', 07:46:28 INFO - 'tabpaint']}, 07:46:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['a11yr', 07:46:28 INFO - 'ts_paint', 07:46:28 INFO - 'tpaint', 07:46:28 INFO - 'sessionrestore', 07:46:28 INFO - 'sessionrestore_no_auto_restore', 07:46:28 INFO - 'tabpaint']}, 07:46:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['a11yr', 07:46:28 INFO - 'ts_paint', 07:46:28 INFO - 'tpaint', 07:46:28 INFO - 'sessionrestore', 07:46:28 INFO - 'sessionrestore_no_auto_restore', 07:46:28 INFO - 'tabpaint']}, 07:46:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:46:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:46:28 INFO - 'bloom_basic_ref']}, 07:46:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['tsvgx', 07:46:28 INFO - 'tsvgr_opacity', 07:46:28 INFO - 'tart', 07:46:28 INFO - 'tscrollx', 07:46:28 INFO - 'cart', 07:46:28 INFO - 'tsvg_static']}, 07:46:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:28 INFO - 'tsvgr_opacity', 07:46:28 INFO - 'tart', 07:46:28 INFO - 'tscrollx', 07:46:28 INFO - 'cart', 07:46:28 INFO - 'tsvg_static']}, 07:46:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'talos_options': ['--disable-e10s'], 07:46:28 INFO - 'tests': ['tp5o']}, 07:46:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'talos_options': ['--disable-e10s', 07:46:28 INFO - '--xperf_path', 07:46:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:28 INFO - 'tests': ['tp5n']}, 07:46:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:28 INFO - 'talos_options': ['--xperf_path', 07:46:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:28 INFO - 'tests': ['tp5n']}}, 07:46:28 INFO - 'talos.zip': {'path': '', 07:46:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:28 INFO - Running post-action listener: _resource_record_post_action 07:46:28 INFO - [mozharness: 2017-04-24 14:46:28.840726Z] Finished populate-webroot step (success) 07:46:28 INFO - [mozharness: 2017-04-24 14:46:28.840859Z] Running create-virtualenv step. 07:46:28 INFO - Running pre-action listener: _resource_record_pre_action 07:46:28 INFO - Running main action method: create_virtualenv 07:46:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:28 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 07:46:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:28 INFO - Using real prefix '/tools/python27' 07:46:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:29 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:32 INFO - Installing pip.................done. 07:46:32 INFO - Return code: 0 07:46:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:32 INFO - Reading from file tmpfile_stdout 07:46:32 INFO - Output received: 07:46:32 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) 07:46:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46:32 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')]} 07:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:33 INFO - 'HOME': '/Users/cltbld', 07:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:33 INFO - 'LOGNAME': 'cltbld', 07:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:33 INFO - 'MOZ_NO_REMOTE': '1', 07:46:33 INFO - 'NO_EM_RESTART': '1', 07:46:33 INFO - 'PAGER': '/bin/cat', 07:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:33 INFO - 'PWD': '/builds/slave/test', 07:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:33 INFO - 'SHELL': '/bin/bash', 07:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:33 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:33 INFO - 'USER': 'cltbld', 07:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:33 INFO - 'XPC_FLAGS': '0x0', 07:46:33 INFO - 'XPC_SERVICE_NAME': '0', 07:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:33 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 07:46:33 INFO - Cleaning up... 07:46:33 INFO - Return code: 0 07:46:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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', '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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:46: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 psutil>=3.1.1 07:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:34 INFO - 'HOME': '/Users/cltbld', 07:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:34 INFO - 'LOGNAME': 'cltbld', 07:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:34 INFO - 'MOZ_NO_REMOTE': '1', 07:46:34 INFO - 'NO_EM_RESTART': '1', 07:46:34 INFO - 'PAGER': '/bin/cat', 07:46:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:34 INFO - 'PWD': '/builds/slave/test', 07:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:34 INFO - 'SHELL': '/bin/bash', 07:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:34 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:34 INFO - 'USER': 'cltbld', 07:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:34 INFO - 'XPC_FLAGS': '0x0', 07:46:34 INFO - 'XPC_SERVICE_NAME': '0', 07:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:34 INFO - Downloading/unpacking psutil>=3.1.1 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:38 INFO - Installing collected packages: psutil 07:46:38 INFO - Running setup.py install for psutil 07:46:38 INFO - building 'psutil._psutil_osx' extension 07:46:38 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 07:46:39 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 07:46:39 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 07:46:39 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 07:46:39 INFO - building 'psutil._psutil_posix' extension 07:46:39 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 07:46:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:39 INFO - ^ 07:46:39 INFO - 1 warning generated. 07:46:39 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 07:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:39 INFO - Successfully installed psutil 07:46:39 INFO - Cleaning up... 07:46:39 INFO - Return code: 0 07:46:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:39 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:39 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 07:46:39 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 07:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:39 INFO - 'HOME': '/Users/cltbld', 07:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:39 INFO - 'LOGNAME': 'cltbld', 07:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:39 INFO - 'MOZ_NO_REMOTE': '1', 07:46:39 INFO - 'NO_EM_RESTART': '1', 07:46:39 INFO - 'PAGER': '/bin/cat', 07:46:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:39 INFO - 'PWD': '/builds/slave/test', 07:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:39 INFO - 'SHELL': '/bin/bash', 07:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:39 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:39 INFO - 'USER': 'cltbld', 07:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:39 INFO - 'XPC_FLAGS': '0x0', 07:46:39 INFO - 'XPC_SERVICE_NAME': '0', 07:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:40 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 07:46:40 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 07:46:40 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 07:46:40 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 07:46:40 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 07:46:40 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 07:46:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:42 INFO - Installing collected packages: mozsystemmonitor 07:46:42 INFO - Running setup.py install for mozsystemmonitor 07:46:43 INFO - Successfully installed mozsystemmonitor 07:46:43 INFO - Cleaning up... 07:46:43 INFO - Return code: 0 07:46:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:43 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 07:46:43 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 07:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:43 INFO - 'HOME': '/Users/cltbld', 07:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:43 INFO - 'LOGNAME': 'cltbld', 07:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:43 INFO - 'MOZ_NO_REMOTE': '1', 07:46:43 INFO - 'NO_EM_RESTART': '1', 07:46:43 INFO - 'PAGER': '/bin/cat', 07:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:43 INFO - 'PWD': '/builds/slave/test', 07:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:43 INFO - 'SHELL': '/bin/bash', 07:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:43 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:43 INFO - 'USER': 'cltbld', 07:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:43 INFO - 'XPC_FLAGS': '0x0', 07:46:43 INFO - 'XPC_SERVICE_NAME': '0', 07:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:43 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:45 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 07:46:45 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 07:46:45 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 07:46:45 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 07:46:45 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 07:46:45 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 07:46:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:46 INFO - warning: no files found matching '*.txt' 07:46:46 INFO - no previously-included directories found matching 'build' 07:46:46 INFO - no previously-included directories found matching 'dist' 07:46:46 INFO - no previously-included directories found matching '.git*' 07:46:46 INFO - Installing collected packages: jsonschema, functools32 07:46:46 INFO - Running setup.py install for functools32 07:46:46 INFO - warning: no files found matching '*.txt' 07:46:46 INFO - no previously-included directories found matching 'build' 07:46:46 INFO - no previously-included directories found matching 'dist' 07:46:46 INFO - no previously-included directories found matching '.git*' 07:46:46 INFO - Successfully installed jsonschema functools32 07:46:46 INFO - Cleaning up... 07:46:46 INFO - Return code: 0 07:46:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:46 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:46 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 07:46:46 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 07:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:46 INFO - 'HOME': '/Users/cltbld', 07:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:46 INFO - 'LOGNAME': 'cltbld', 07:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:46 INFO - 'MOZ_NO_REMOTE': '1', 07:46:46 INFO - 'NO_EM_RESTART': '1', 07:46:46 INFO - 'PAGER': '/bin/cat', 07:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:46 INFO - 'PWD': '/builds/slave/test', 07:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:46 INFO - 'SHELL': '/bin/bash', 07:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:46 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:46 INFO - 'USER': 'cltbld', 07:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:46 INFO - 'XPC_FLAGS': '0x0', 07:46:46 INFO - 'XPC_SERVICE_NAME': '0', 07:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:47 INFO - Cleaning up... 07:46:47 INFO - Return code: 0 07:46:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:47 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')]} 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 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')]} 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:47 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 07:46:47 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 07:46:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:47 INFO - 'HOME': '/Users/cltbld', 07:46:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:47 INFO - 'LOGNAME': 'cltbld', 07:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:47 INFO - 'MOZ_NO_REMOTE': '1', 07:46:47 INFO - 'NO_EM_RESTART': '1', 07:46:47 INFO - 'PAGER': '/bin/cat', 07:46:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:47 INFO - 'PWD': '/builds/slave/test', 07:46:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:47 INFO - 'SHELL': '/bin/bash', 07:46:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:47 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:47 INFO - 'USER': 'cltbld', 07:46:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:47 INFO - 'XPC_FLAGS': '0x0', 07:46:47 INFO - 'XPC_SERVICE_NAME': '0', 07:46:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:47 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 07:46:47 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 07:46:47 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 07:46:47 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 07:46:47 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 07:46:47 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 07:46:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:49 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 07:46:49 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 07:46:49 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 07:46:49 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 07:46:49 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 07:46:49 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 07:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:51 INFO - Downloading docopt-0.6.1.tar.gz 07:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:51 INFO - Running setup.py install for blobuploader 07:46:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:51 INFO - Running setup.py install for requests 07:46:51 INFO - Running setup.py install for docopt 07:46:51 INFO - Successfully installed blobuploader requests docopt 07:46:51 INFO - Cleaning up... 07:46:52 INFO - Return code: 0 07:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:52 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')]} 07:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 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')]} 07:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:52 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:52 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 07:46:52 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 07:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:52 INFO - 'HOME': '/Users/cltbld', 07:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:52 INFO - 'LOGNAME': 'cltbld', 07:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:52 INFO - 'MOZ_NO_REMOTE': '1', 07:46:52 INFO - 'NO_EM_RESTART': '1', 07:46:52 INFO - 'PAGER': '/bin/cat', 07:46:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:52 INFO - 'PWD': '/builds/slave/test', 07:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:52 INFO - 'SHELL': '/bin/bash', 07:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:52 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:52 INFO - 'USER': 'cltbld', 07:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:52 INFO - 'XPC_FLAGS': '0x0', 07:46:52 INFO - 'XPC_SERVICE_NAME': '0', 07:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-sCbGEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Bvg0Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-rMVr8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-9Uycoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-M1xACH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-w2AG6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:52 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-m9Cz7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-tpgw7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-y5zuJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-kxk6se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-IKA2Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-KB33EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-_HMnhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-epIPNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-TqR90B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-7FQPtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:53 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-1NlNDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:54 INFO - Running setup.py install for manifestparser 07:46:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozcrash 07:46:54 INFO - Running setup.py install for mozdebug 07:46:54 INFO - Running setup.py install for mozdevice 07:46:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozfile 07:46:54 INFO - Running setup.py install for mozhttpd 07:46:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozinfo 07:46:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Running setup.py install for mozInstall 07:46:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Running setup.py install for mozleak 07:46:55 INFO - Running setup.py install for mozlog 07:46:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Running setup.py install for moznetwork 07:46:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:55 INFO - Running setup.py install for mozprocess 07:46:55 INFO - Running setup.py install for mozprofile 07:46:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:56 INFO - Running setup.py install for mozrunner 07:46:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:56 INFO - Running setup.py install for mozscreenshot 07:46:56 INFO - Running setup.py install for moztest 07:46:56 INFO - Running setup.py install for mozversion 07:46:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:56 INFO - Cleaning up... 07:46:56 INFO - Return code: 0 07:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:56 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:46:56 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 07:46:56 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 07:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:56 INFO - 'HOME': '/Users/cltbld', 07:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:56 INFO - 'LOGNAME': 'cltbld', 07:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:56 INFO - 'MOZ_NO_REMOTE': '1', 07:46:56 INFO - 'NO_EM_RESTART': '1', 07:46:56 INFO - 'PAGER': '/bin/cat', 07:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:56 INFO - 'PWD': '/builds/slave/test', 07:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:56 INFO - 'SHELL': '/bin/bash', 07:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:46:56 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:56 INFO - 'USER': 'cltbld', 07:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:56 INFO - 'XPC_FLAGS': '0x0', 07:46:56 INFO - 'XPC_SERVICE_NAME': '0', 07:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:56 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-tqzZTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-MqovVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Zo6ohq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-L_CYjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-h_xeJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-lnYH0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-QhnlDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-RgKkd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Pn7cZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-eaEYZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:57 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)) 07:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-JuSByo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:58 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)) 07:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-dVDnp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:58 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)) 07:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-k2wHfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:58 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)) 07:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Tyzb3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:58 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)) 07:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Vwj4xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:58 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)) 07:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-qlRBdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:58 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)) 07:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-_48z95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:58 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:46:58 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 07:47:01 INFO - Downloading blessings-1.6.tar.gz 07:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:01 INFO - Installing collected packages: blessings 07:47:01 INFO - Running setup.py install for blessings 07:47:01 INFO - Successfully installed blessings 07:47:01 INFO - Cleaning up... 07:47:01 INFO - Return code: 0 07:47:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:01 INFO - Reading from file tmpfile_stdout 07:47:01 INFO - Current package versions: 07:47:01 INFO - blessings == 1.6 07:47:01 INFO - blobuploader == 1.2.4 07:47:01 INFO - docopt == 0.6.1 07:47:01 INFO - functools32 == 3.2.3-2 07:47:01 INFO - jsonschema == 2.5.1 07:47:01 INFO - manifestparser == 1.1 07:47:01 INFO - mozInstall == 1.12 07:47:01 INFO - mozcrash == 1.0 07:47:01 INFO - mozdebug == 0.1 07:47:01 INFO - mozdevice == 0.50 07:47:01 INFO - mozfile == 1.2 07:47:01 INFO - mozhttpd == 0.7 07:47:01 INFO - mozinfo == 0.9 07:47:01 INFO - mozleak == 0.1 07:47:01 INFO - mozlog == 3.4 07:47:01 INFO - moznetwork == 0.27 07:47:01 INFO - mozprocess == 0.25 07:47:01 INFO - mozprofile == 0.28 07:47:01 INFO - mozrunner == 6.13 07:47:01 INFO - mozscreenshot == 0.1 07:47:01 INFO - mozsystemmonitor == 0.3 07:47:01 INFO - moztest == 0.8 07:47:01 INFO - mozversion == 1.4 07:47:01 INFO - psutil == 3.1.1 07:47:01 INFO - requests == 1.2.3 07:47:01 INFO - wsgiref == 0.1.2 07:47:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:01 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')]} 07:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:01 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')]} 07:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:01 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 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:47:01 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 07:47:01 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 07:47:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:47:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:01 INFO - 'HOME': '/Users/cltbld', 07:47:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:01 INFO - 'LOGNAME': 'cltbld', 07:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:01 INFO - 'MOZ_NO_REMOTE': '1', 07:47:01 INFO - 'NO_EM_RESTART': '1', 07:47:01 INFO - 'PAGER': '/bin/cat', 07:47:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:01 INFO - 'PWD': '/builds/slave/test', 07:47:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:01 INFO - 'SHELL': '/bin/bash', 07:47:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:47:01 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:47:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:01 INFO - 'USER': 'cltbld', 07:47:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:01 INFO - 'XPC_FLAGS': '0x0', 07:47:01 INFO - 'XPC_SERVICE_NAME': '0', 07:47:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 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)) 07:47:02 INFO - Cleaning up... 07:47:02 INFO - Return code: 0 07:47:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105976b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105979768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0204a4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, '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.ZxL7mTewQM/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.9mVNkeslqf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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 07:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:02 INFO - 'HOME': '/Users/cltbld', 07:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:02 INFO - 'LOGNAME': 'cltbld', 07:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:02 INFO - 'MOZ_NO_REMOTE': '1', 07:47:02 INFO - 'NO_EM_RESTART': '1', 07:47:02 INFO - 'PAGER': '/bin/cat', 07:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:02 INFO - 'PWD': '/builds/slave/test', 07:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:02 INFO - 'SHELL': '/bin/bash', 07:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:47:02 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:02 INFO - 'USER': 'cltbld', 07:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:02 INFO - 'XPC_FLAGS': '0x0', 07:47:02 INFO - 'XPC_SERVICE_NAME': '0', 07:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:02 INFO - Cleaning up... 07:47:02 INFO - Return code: 0 07:47:02 INFO - Running post-action listener: _resource_record_post_action 07:47:02 INFO - Running post-action listener: _start_resource_monitoring 07:47:02 INFO - Starting resource monitoring. 07:47:02 INFO - [mozharness: 2017-04-24 14:47:02.486060Z] Finished create-virtualenv step (success) 07:47:02 INFO - [mozharness: 2017-04-24 14:47:02.487093Z] Running install step. 07:47:02 INFO - Running pre-action listener: _resource_record_pre_action 07:47:02 INFO - Running main action method: install 07:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:02 INFO - Reading from file tmpfile_stdout 07:47:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:02 INFO - Reading from file tmpfile_stdout 07:47:02 INFO - Output received: 07:47:02 INFO - Usage: mozinstall [options] installer 07:47:02 INFO - Options: 07:47:02 INFO - -h, --help show this help message and exit 07:47:02 INFO - -d DEST, --destination=DEST 07:47:02 INFO - Directory to install application into. [default: 07:47:02 INFO - "/builds/slave/test"] 07:47:02 INFO - --app=APP Application being installed. [default: firefox] 07:47:02 INFO - mkdir: /builds/slave/test/build/application 07:47:02 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'] 07:47:02 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 07:47:22 INFO - Reading from file tmpfile_stdout 07:47:22 INFO - Output received: 07:47:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:47:22 INFO - Running post-action listener: _resource_record_post_action 07:47:22 INFO - [mozharness: 2017-04-24 14:47:22.531199Z] Finished install step (success) 07:47:22 INFO - [mozharness: 2017-04-24 14:47:22.531328Z] Running run-tests step. 07:47:22 INFO - Running pre-action listener: _resource_record_pre_action 07:47:22 INFO - Running main action method: run_tests 07:47:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:22 INFO - 2017-04-24 07:47:22.545 screenresolution[1621:7353] starting screenresolution argv=screenresolution get 07:47:22 INFO - 2017-04-24 07:47:22.548 screenresolution[1621:7353] Display 0: 1600x1200x32@60 07:47:22 INFO - 2017-04-24 07:47:22.554 screenresolution[1622:7356] starting screenresolution argv=screenresolution list 07:47:22 INFO - Available Modes on Display 0 07:47:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:22 INFO - Intel Iris: 07:47:22 INFO - Chipset Model: Intel Iris 07:47:22 INFO - Type: GPU 07:47:22 INFO - Bus: Built-In 07:47:22 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:22 INFO - Vendor: Intel (0x8086) 07:47:22 INFO - Device ID: 0x0a2e 07:47:22 INFO - Revision ID: 0x0009 07:47:22 INFO - Displays: 07:47:22 INFO - Display: 07:47:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:22 INFO - Display Serial Number: 1600x1200 60 07:47:22 INFO - Main Display: Yes 07:47:22 INFO - Mirror: Off 07:47:22 INFO - Online: Yes 07:47:22 INFO - Rotation: Supported 07:47:22 INFO - Return code: 0 07:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:22 INFO - Python 2.7.3 07:47:22 INFO - Return code: 0 07:47:22 INFO - grabbing minidump binary from tooltool 07:47: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')]} 07:47:22 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 0x105754d30>, '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 0x10567adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105749be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:22 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 07:47:22 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 07:47:22 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 07:47:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:22 INFO - Return code: 0 07:47:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:22 INFO - ENV: RUST_BACKTRACE is now 1 07:47:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:22 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/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--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 07:47:22 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/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0392 --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 07:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZxL7mTewQM/Render', 07:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:22 INFO - 'HOME': '/Users/cltbld', 07:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:22 INFO - 'LOGNAME': 'cltbld', 07:47:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:22 INFO - 'MOZ_NO_REMOTE': '1', 07:47:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:22 INFO - 'NO_EM_RESTART': '1', 07:47:22 INFO - 'PAGER': '/bin/cat', 07:47:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:22 INFO - 'PWD': '/builds/slave/test', 07:47:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:22 INFO - 'RUST_BACKTRACE': '1', 07:47:22 INFO - 'SHELL': '/bin/bash', 07:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mVNkeslqf/Listeners', 07:47:22 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 07:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:22 INFO - 'USER': 'cltbld', 07:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:22 INFO - 'XPC_FLAGS': '0x0', 07:47:22 INFO - 'XPC_SERVICE_NAME': '0', 07:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:22 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/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--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 07:47:23 INFO - mozversion application_buildid: 20170424065420 07:47:23 INFO - mozversion application_changeset: 62b649c6b314f756f21cb95f2b0d491e2664e944 07:47:23 INFO - mozversion application_display_name: Nightly 07:47:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:23 INFO - mozversion application_name: Firefox 07:47:23 INFO - mozversion application_remotingname: firefox 07:47:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:23 INFO - mozversion application_vendor: Mozilla 07:47:23 INFO - mozversion application_version: 55.0a1 07:47:23 INFO - mozversion platform_buildid: 20170424065420 07:47:23 INFO - mozversion platform_changeset: 62b649c6b314f756f21cb95f2b0d491e2664e944 07:47:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:23 INFO - mozversion platform_version: 55.0a1 07:47:23 INFO - using testdate: 1493045243 07:47:23 INFO - actual date: 1493045243 07:47:23 INFO - starting webserver on 'localhost:49236' 07:47:23 INFO - SUITE-START | Running 2 tests 07:47:23 INFO - TEST-START | dromaeo_css 07:47:23 INFO - operating with platform_type : mac_ 07:47:23 INFO - Initialising browser for dromaeo_css test... 07:47:23 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpFB_lIZ/profile http://localhost:49236/getInfo.html) 07:47:26 INFO - PID 1632 | 2017-04-24 07:47:26.078 plugin-container[1634:7542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b3f, name = 'com.apple.tsm.portname' 07:47:26 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:47:26 INFO - PID 1632 | 2017-04-24 07:47:26.081 plugin-container[1634:7542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c17, name = 'com.apple.CFPasteboardClient' 07:47:26 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:47:26 INFO - PID 1632 | 2017-04-24 07:47:26.081 plugin-container[1634:7542] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:47:26 INFO - PID 1632 | __metrics Screen width/height:1600/1200 07:47:26 INFO - PID 1632 | colorDepth:24 07:47:26 INFO - PID 1632 | Browser inner width/height: 1024/689 07:47:26 INFO - PID 1632 | __metrics 07:47:26 ERROR - PID 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 07:47:27 INFO - TEST-INFO | 1632: exit 0 07:47:27 INFO - Browser initialized. 07:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:27 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpFB_lIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:29 INFO - PID 1638 | 2017-04-24 07:47:29.923 plugin-container[1639:7727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923b, name = 'com.apple.tsm.portname' 07:47:29 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:47:29 INFO - PID 1638 | 2017-04-24 07:47:29.924 plugin-container[1639:7727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4427, name = 'com.apple.CFPasteboardClient' 07:47:29 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:47:29 INFO - PID 1638 | 2017-04-24 07:47:29.924 plugin-container[1639:7727] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:47:39 INFO - PID 1638 | RSS: Main: 235646976 07:47:39 INFO - PID 1638 | 07:50:43 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 07:50:45 INFO - PID 1638 | RSS: Main: 253018112 07:50:45 INFO - PID 1638 | 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 07:52:27 INFO - PID 1638 | 07:52:27 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:27 INFO - PID 1638 | Full stack: 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 07:52:27 INFO - PID 1638 | 07:52:27 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:27 INFO - PID 1638 | Full stack: 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 07:52:27 INFO - PID 1638 | 07:52:27 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:27 INFO - PID 1638 | Full stack: 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | ************************* 07:52:27 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task. 07:52:27 INFO - PID 1638 | 07:52:27 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:27 INFO - PID 1638 | Full stack: 07:52:27 INFO - PID 1638 | ************************* 07:53:47 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 07:53:47 INFO - PID 1638 | RSS: Main: 256905216 07:53:47 INFO - PID 1638 | 07:56:49 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 07:56:50 INFO - PID 1638 | RSS: Main: 267087872 07:56:50 INFO - PID 1638 | 07:59:51 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 07:59:52 INFO - PID 1638 | RSS: Main: 259944448 07:59:52 INFO - PID 1638 | 08:02:55 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:02:56 INFO - PID 1638 | RSS: Main: 269197312 08:02:56 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:05:57 INFO - PID 1638 | RSS: Main: 264024064 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | __start_tp_report 08:05:57 INFO - PID 1638 | _x_x_mozilla_page_load 08:05:57 INFO - PID 1638 | _x_x_mozilla_page_load_details 08:05:57 INFO - PID 1638 | |i|pagename|runs| 08:05:57 INFO - PID 1638 | |0;dojo.html;3287.736981041514;3615.529981102456;3621.34815733168;3660.5790334111584;3662.4689420034097;4724.24412094065;6111.865232675502;6143.477804386627;6197.535184861136;6305.716242769075;6173.876522469548;6179.412955769206;6204.813855584329;6242.625442473443;6287.025511045784;5144.614153938451;5468.453154684539;5494.450554944504;5530.198121272413;5584.804531841386;5404.000259951902;5493.23094766733;5587.38538760736;5621.718914054301;5664.54683625309;5384.461553844623;5422.864428389283;5425;5521.978433989725;5558.388577256519;5444.40111587725;5501.229827824108;5502;5509.834704958857;5568.49883510482;5422.349318081816;5438.755256013489;5455.1271796512365;5458.699771512565;5476.726163691839;5987.760489580412;6112.266528016622;6162.96918515409;6206.72069756862;6222.782202622887;6544.607323560554;6634.568753031038;6649.767258145942;6653;6679.398854103106;6757.6822519608695;6759.459243260528;6764.729410823561;6771.72913083476;6772.525923185379;6139.693015349215;6272.18461599989;6287.371262873722;6309.2428908530355;6310;6770.356816102462;6857.211420686585;6880.346367095118;6919.238883722786;6928.44572434204;6313.810585682437;6385.48916086712;6568.86862262752;6617.272100068989;6641.468682505388;5193.662411943212;5914.172015917775;6320.494360451153;6720.798376048726;6730.158730158731;6690.498212634072;6702.932970670328;6703.29615390377;6705.295943925915;6712.261651218362;6396.168498095218;6464.741410343628;6477.8704425912165;6556.901646475307;6559.147310849655;5343.545798607084;5347.064263753905;5356.517913387814;5379.919301210485;5396.91904621431;4766.95233047672;4768.856934291976;4789.976050119727;4792.305115758196;4824.517548245148;4956.529129732669;6196.132541444202;6236.251649801962;6281.183446151971;6384.138141350858;6652.301508341651;6720.966395167993;6721.395074443323;6740.157480314961;6744.932550674529;6263.373662633791;6288.245410550763;6292.307846136921;6316.178896743394;6344.936550634527;5750.913736293959;5802;5948;5965.164876917235;5970.955082860482;6826.180858297036;6876.381125698711;6902.758403455855;6929;6936.687849046704;6771.762988295583;6789.321067893368;6805.251422343637;6810.046593477016;6810.353016463428;6257.7184026718;6732.562383445061;6913;6973.407260382722;7004.3696067354185;5390.703511306916;6448.193975753031;6647.933520664731;6667.566608170453;6692.397684208445;6690.565113267622;6775.322467753383;6823.249442561215;6827.931720682928;6834.453243740588;6291.653959032297;6397.200349956255;6397.360263973565;6573.276939536743;6615.66921653925;5433.945660543344;6468.482521398183;6487.578307410004;6507.446867016357;6539.182602174728;5887.1757953885635;6034;6428.260750013808;6430.196225471816;6466.06242094903;6263.154474145932;6583.078369028436;6605.47156227491;6609.669516524251;6710.966445167743;6227.06594010902;6236.18929539157;6286.057091436322;6356.014817703079;6356.904646430215 08:05:57 INFO - PID 1638 | |1;ext.html;709.6168069242606;770.6300975531744;800.2637573432442;1151.6890439581314;1155.6995181252883;37918.81040594797;38535.42196867049;38541.421878671805;38554.421683674766;38579.22841543167;39209.60790392095;39245.41131883024;39509.40735888957;39583.20833583327;39734.80132599333;7762.379009679226;7881.921180788176;8454.365922555802;8721.7819554511;8778.6927457539;8627.396082274243;8714.782130446727;8729.956350218241;8745.518996455192;8751.912480875206;8640.2223799858;8653.69712060078;8738.563071846414;8740.213380795727;8765.079666635007;8661.566921653925;8692.43499172555;8709.95645021777;8713.7821554461;8723;8383.874241886377;8428.157184281585;8450.112738162466;8455.53494557799;8459.66161353545;38485.23029539421;38631.613683863085;38638;38805.80597096997;38843.8057809712;3567.571891373026;3568.6966607838367;3604.9098772530633;3604.9279014419567;3608.386574282378;22975.885120574458;31473.685263147305;31747.52378714321;31811.84094079538;31861.362772744415;2716.7419095185924;3159.8104113753247;3197.6802319767835;3197.6962188592047;3206.839658017113;252975;258307;266068;299794;300628;41560.79219603883;45592.54407455949;47417.525824742;47677.284840727414;47826;47934.56196314116;48239;48343.274850877264;48415.03169936581;48517;13731.725365492634;13845.961552883575;13852.584422467342;13854.584362469142;13855.86144138566;11443.828342574869;11457.427128643534;11462.713432164095;11485.023772979222;11511.942440287912;13559.864401356057;13655.04414690982;13663.111897726814;13699.794503082461;13703.45186192561;5448.318960129984;5604.8318550443555;5948.464638182584;5956.672383018976;6001.669908155006;1006.2201793609864;1014.300132908291;1014.325473560089;1048.0305717211702;1057.2387880725864;19949;23516.412089697893;24482.632760508608;24580.754192457847;24899.502009960062;1031.5306535526317;1104.6685994201707;1110.1895616200059;1151.2919554474106;1152.2855829385835;10360;11079.892010799016;12129.02967762577;12642.873571264354;12738.936305318413;324619;325812;325897;326379;326966;54144.45855541473;54400.45599543954;54576;54577;54724.45275547194;1448.833384160814;1496.132243298906;1525.5270866031565;1526.6183454136467;1530.3113598880548;24464.388390290384;24587.508249834544;24703.258902232963;24718.13486527963;24781.504369912862;39147.608523914394;50037.74905627388;50785.73035674138;50842;51106.74446627743;260698;260804;260843;261567;261775;29533;30099.849500752356;34377.65622343744;34399.828000860834;34945;35303;44279.11441771082;44766.10467790691;45345.54654453413;45623.31565026461;30887.69112308848;30958.0712578623;31141.8442907784;31384.901528446393;31434.842825785723;30298;31056.534151987285;31138.844305778326;31270;31578;36784.89645310645;37581.06047348838;38230.2353952925;39099.02252443712;39112.80443597764;31919.521207182377;32168.67831321657;32390.35219295648;32649.510257346636;32852.014439566854;19347.548933829738;23618.882771038087;24862.63255520964;25165.609267119595;25209.621855671812 08:05:57 INFO - PID 1638 | |2;jquery.html;424.96600271978207;432.44862799930087;435.83656128951645;456.0855484753072;459.80228501744244;16913.915430422847;18452.892826430423;21652.783472165273;22005.779942200574;22213.66679499807;21607.783922160772;22056.8897155514;22201.22295719646;22391;23001.539969200607;5744.621290890177;6129.203203583528;6343.048542718583;6344.206974128234;6353.777617783378;5513;5788.768449262025;5969.641821490724;6296.842578935518;6300;5567.832965011056;6018.7893423730175;6163.907541386883;6262.780802671908;6279.654618995954;5690.687012214326;5816.1275808628625;6186.56694031418;6195.2255968004;6279.183706118199;5279.815206467793;5494.36814766303;5514.200440936042;5562.610617256793;5578;21680.674789878165;27053.323666908484;27216.455670886473;27469.862650686817;27484.175474735788;2254.402583315423;2285.5543169082034;2308.8845557722216;2322.2336628912417;2329.650552417151;13501.122427042212;14394.928025359912;17463.86484878479;17765.46703598881;18283.72574411385;2187.1360812478983;2195;2198;2215.523662412589;2216.612092883755;148736;166427;169234;170395;170847;12882.935585322013;12954.80567791484;12960.611181664564;13095.803562946563;13136.146150500186;16640.6671866562;16792.748108778134;16851.915740421464;16904.239309231114;16915.985040897587;8791.252743516872;9090.727278181665;9132.543372831331;9286.95356523213;9297.488638124833;8630.39587228888;8717.12828717136;8722.825543489094;8875.955620221857;8906.332025098143;7950.165232650604;8063.879041814377;8067.677292908218;8114.188581141839;8122.837543249102;2017.7074324222906;2166.2851259084464;2171.9891400542897;2173.7608863025052;2177.194438057929;954.656323723459;983.9458829764288;993.24513369838;1028.290479569095;1029.156092004549;15494;21006.78993210079;21860.89069554642;21942.89028554847;22050.779492205194;1010.6210171185805;1012.4330374990029;1040.6201736366172;1043.2905624175633;1050.8791488978866;11089.5564177432;13058.49827269857;13465.182200403016;13674.589762307147;14213.933954953212;571211;578041;582209;593459;594642;123010;125611.3719431397;127179;134697.32651336875;135874.3206283982;1183.7573297473998;1200.543793358518;1252.8183413405004;1254.3853511779162;1259.0934527140444;22063.779362206173;22392.104315827186;22682.092716291823;22737.31788046361;22763.772362276166;58012.12981805361;58558;58986.705066474395;59561;60301.39698602958;82582.58708706418;83011.5849420749;83645;83842.74235886344;83981;8876.822463550821;8953.194212520904;8976.922769267469;8996;9057.728268151966;11811.527538898348;11901.583444579399;12660.556880509139;13582.320883955961;14317.498887538886;10711.41087240178;10877.728056798644;11404.714882128013;11774.705632359259;11920.52317907274;11007.009369156815;11361;11453.255538389978;11501.597444089417;11810.704732381759;11828.881711182778;12095.879041209475;12126.211796233569;12149;12291.016718662664;8076.83846323082;8722.084181160886;8986.460812351279;9155.679551215675;9171.082891711043;11717.06263498935;11767.823482647596;11905.40472976365;11933.985611222795;12148.514059437877 08:05:57 INFO - PID 1638 | |3;mootools.html;1398.8810951069158;1421.850705675904;1435.7702767557194;1452.3537026023416;1460.0874453466583;11675.41622918855;11968.461419236133;12229.633111006662;12230.266184028953;12342.19775714578;11964.880351196485;12046.81929771052;12207.145499815017;12217.694557636041;12238.143329966884;2572.691277046757;2583.560794664902;2586.249987503631;2588.676415448069;2588.8317259378173;2513.2334637935423;2569.6530968319225;2572.909948151815;2576.5877459606468;2577.6520169777027;2528.05198050731;2553.4893021395796;2570.4602033572974;2579.3551612096976;2580.703219129796;2509.736477669846;2531.7215106338194;2550.2094350751327;2559.2341284513814;2561.9615705764427;2111.5354621983292;2169.783021697833;2524.6213068039756;2527.2923581397054;2529.3929456930387;11790.646280611509;12114.21257618252;12342.568010119603;12366.948809351215;12373.752524949541;5961.837441698871;6723.823330917119;6832.3509266620085;7006.6496675166545;7008.299170082951;3398.490226466025;4177.10192308652;4357.9976605380625;4466.062126953344;4478.484974227973;1257.0195247706804;1276.2725246609436;1305.8563558008611;1306.751717173734;1309.3584143769485;17060.402885899057;17079.82920170807;17190.1404929753;17191.656166876717;17224.913875430542;5138.306328645585;5316.122839731401;5677.716114194356;5839.124131380242;5907.172995780594;12491.562795302121;12578.55975040869;12606.180598261084;12609.747805044031;12612.621621351374;6778;6779.2881747416795;6779.62712050832;6788.49086318528;6788.524803263823;5239.5284424401225;5351.170568561879;6065.332813390612;6202.658853763086;6253.937460625427;4434.224010798098;4520.254158063948;4530.77346132692;4536.319552067151;4636.559526844944;1303.0422639360063;1317.4730107956893;1321.7885138377812;1335.5659410691565;1337.1041402260314;793.4326956226325;801.8933871257627;822.9753107406788;824.4640983360863;848.6562942008496;6219.160413344141;6290.622562646256;6402.647854368054;6476.222853257545;6548.476121910236;589.345826132992;603.8973374526341;605.3855336833118;607.471499795181;618.9566730328924;3350.9162270942934;3956.8219430125714;4104.076582768913;4538.069695712371;4561.407017087758;15050.397984080515;15174.772378414333;15250.237488125771;15519.45681901128;15519.45681901128;12841.972642188603;15096.54710358691;15414;15512.457064002705;15580.610484737972;8724.956375218084;8799.076097009849;8829.823403532022;8907.821843563223;8944.597493112826;7080.04419403374;7219.711211551479;7409.184989651027;7431.256874312742;7445.7766267012075;13545.729085418434;13694.109882857583;13851;13946.16323020622;14039.227842468354;14094.9428792843;14105.224212667992;14130.646733831736;14216;14248.35882385316;9629.133377996013;9715.417074975525;9807.21542276602;9809.656662017082;9846.507674616098;10872.347659140476;10907;10979.505922233679;10995.560177592806;11015.118790496581;9222.584983675884;9292.349535532718;9407.294452916196;9419.246460283299;9532.332736708364;9130.543472826199;9131.315151363542;9210.171084602418;9266.814663706553;9285.164335209864;8270.793230169294;8356.623951922056;8373;8449.915500844912;8500.44747091437;6044.516438684806;6166.845828854314;6196.876062478816;6337.112804207507;6346.587471814502;5386.649867758583;6150.554619664285;6355.459785918249;6379.425851673372;6395.232572091379 08:05:57 INFO - PID 1638 | |4;prototype.html;346.9496922946173;353.60043151239097;401.36784564311216;404.43379269023364;411.92791261529226;4903.730294833783;5908.320543137541;6103.145559621651;6175.4252665570275;6183.6289822610615;4427.380166776646;6080.662254304057;6082.361352058026;6088;6114.205153330072;3740.3641380965164;3869.4776205212356;4651.953480465194;4664.696794708333;4668.439787225538;4480.19356515827;4630.560096790799;4693.507181745918;4696.131215725085;4696.765161741916;4594.218982772936;4604.1482325769675;4614.884627884313;4616.97691511542;4630.884227894296;4637.397138372024;4648.328429927918;4671.416072990876;4675.906481870344;4690.366800481926;3686.3227231609553;3791.317562838688;4147.502299724022;4155.898686847988;4161.56303588125;5132.3327967364;5410.729463526808;5645.887082258373;5869.178315035856;5885.528617845539;4408.955910440886;5304.469553044703;5322.5209731124;5326.97336513315;5339.759710813023;6322.530603315397;6350.618962862243;6439;6496.577722448026;6496.772612958571;4362.90927268183;4366.104948485585;4375.037491751809;4382.517923028464;4384.649228061748;5266.526012658841;5466;6274.498040156822;6849.1780986281465;6908.1364829396825;3586.2648157128247;4332.718373305725;4411.632393957883;4423.92075724409;4440.134173836135;4502.996166705784;4504.752238626907;4526.524714904954;4536.754306618245;4559.603095693663;4454.331850222427;4797.368894575861;4899.902001960012;5302.893942121136;5337.97157080307;5632.52123569493;6481.4166724994975;6495.3179916109075;6512.772052978123;6533.314002029813;1311.731095125497;1533.7852700621922;1545.5054382597461;1549.9225038748018;1554.1529866222936;836.2891542189091;915.4507295622707;966.0436168193438;1003.6738060130341;1026.5483187397522;5188.45521220274;5800.8259752207505;5804.04233301509;6140.293866205354;6178.474829639441;5835.708214589254;6733.6296503692765;6737;6744.494162937799;6766.458683305324;5841.4450627190345;6006.5495087868585;6067.029275315928;6118.265808103056;6138.78514252008;3090.752739780812;3242.773005889565;3336.59960804705;3485.337785820686;3494.7029502492064;5511.311086114236;5568.44315568448;6338;6898.517103802786;6970.895436568456;5481.177823326453;5808.651480911159;6972.755953541703;7026.789196324118;7050.506464547432;6770.93229067703;6953.33943275388;6971.407430368476;7010.334018268256;7067.893981590178;5958.910616340845;6001.879962400815;6616.172978377703;6866.931330686829;6933.618650974245;6397.424231818973;6689.632070235989;6703.491714364229;6736.292689267556;6755.344940489612;6046.637201767908;6969.6515174242095;6978.965105174645;6993.685284162123;7016.6491675415;3958.9208215836097;4078.898027549335;4182.2681030820095;4427.5572442755465;4440.333949907411;5400.540954018796;6721.327867213239;6772.458203343622;6773.762918297836;6774.153230846145;5338.759755811076;6517.804465866032;6534.386245501837;6536.477081833346;6541;5361.705106219039;6210;6448.29068802422;6467.482601391972;6521.250056243593;5256.579473642176;5564.638298510584;6376.776812811529;6379.819733349345;6408.58344207625;6411;6495.317991610813;6503.869922601427;6534.542582019213;6556.868862622626;5290.1800220965815;5781.913271301018;5989.293051480307;6333.334999825136;6398.584092034003 08:05:57 INFO - PID 1638 | |5;yui.html;834.2866848844242;836.105367257035;840.5755093677692;871.424859592669;874.4010352908257;15999.760003599955;16661.250243739032;16666.416675416363;18560.721589176173;19296.421107366765;17553;17907.462776116736;18060.096995150256;18099.27602895886;18304.542386440346;974.4543055888707;978.2027647467291;982.2093214961952;982.8083523712879;985.4136788610801;987.6543209876558;988.4020167798486;988.7132731507854;989.7278248481689;991.3952488981715;1036.7200855768938;1042.8696412948382;1045.592219034577;1045.8222102242637;1046.7592453735645;1023.1814548361281;1024.0578667625728;1037.5953378182514;1038.3458421194637;1040.745017470717;674.1472037872096;690.3959035843637;734.3280897978343;747.6710247491086;748.7791101625033;16797.99212047269;16860.66278674432;16870.240839162267;17032.82967170325;17058.48824535266;17155.485335439957;17174.484765457055;17433.38983135597;17480.82519174805;17586.032768197743;12237.938810305892;14056.086354387035;14308.069975451666;14363.497277595234;14367.425302987867;3418.931621367559;3489.3021395720957;3492.0396890854963;3494.318607871466;3500.3699334119847;133372;134294;134937;137140;137206.3139684305;12883;13045.804312935314;13101.737965240642;13268.601941941757;13304;25623.871880640476;25757.227283181535;25826.483470330488;25870.353241169123;25933.22200333993;7524.887126693104;7528.397728181732;7547.50941188821;7641.235876412315;7647;3891.1633998690418;3962.108525581779;3976.005998500375;3981.7411868228473;3991.640752332304;4231.682623803227;4287.828486860553;4343.804528796211;4458.219811532968;4744.501827308152;834.4117397234935;966.6997887840843;991.0683957080322;995.2535598301274;997.6159178716247;548.5940404100936;641.323403808986;647.7376662451715;668.5220067651652;685.3420716112488;10807.243492955575;11093.278936869077;11595.76808463826;12005.09961752872;12054.638360849189;619.9380061993764;639.964801935898;640.7148818775601;674.0967104080555;684.8116767888871;4999.250112483084;5206.906549624546;5383.7308134593895;5623.297087864017;5685.857853553612;104033.47983260186;105301.94698053075;108874.45562772294;112035;112414;90105.54947225354;93120;95453.5227323859;97674;98518;80530;80706.59646701728;80923.5953820239;81076;83354;12371.257724536557;12809.487620495449;12815.743685126059;12827.615171544869;12845.293508856728;39937.80031099826;41148.79425602853;42027.7898610505;42344.82413818914;42617.1476570473;53710.73144634252;53880.46119538754;54322.91354172974;54692.17961730657;54899.451005491035;15402.691946161238;15499.302531385889;15549.922250388676;15582.84417155814;16330.346786128897;15420.614484637525;17950.640987180446;18514;18696.719549207046;18800.435986920413;16924.492265232064;17062.232199551298;17076.573085672957;17220.311187552357;17259.654806904044;16505.257263422936;17079.231434585723;17134.543563796717;17300.48098557045;17409.738853916948;16375.67248655044;16430.507084787474;16908.32366705318;16948.830511694727;17188.484345469657;10382.857885632726;10450.634227801991;11567.132465065322;11925.4037298133;11994.100442466675;11470.19708620422;13209.801852972021;13254.53609123676;13296.534621288209;13358.666033349244 08:05:57 INFO - PID 1638 | __end_tp_report 08:05:57 INFO - PID 1638 | __start_cc_report 08:05:57 INFO - PID 1638 | _x_x_mozilla_cycle_collect,419 08:05:57 INFO - PID 1638 | __end_cc_report 08:05:57 INFO - PID 1638 | __startTimestamp1493046357974__endTimestamp 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | ------- Summary: start ------- 08:05:57 INFO - PID 1638 | Number of tests: 6 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6126.69 Median:6309.24 stddev:727.18 (11.5%) stddev-sans-first:694.47 08:05:57 INFO - PID 1638 | Values: 3287.7 3615.5 3621.3 3660.6 3662.5 4724.2 6111.9 6143.5 6197.5 6305.7 6173.9 6179.4 6204.8 6242.6 6287.0 5144.6 5468.5 5494.5 5530.2 5584.8 5404.0 5493.2 5587.4 5621.7 5664.5 5384.5 5422.9 5425.0 5522.0 5558.4 5444.4 5501.2 5502.0 5509.8 5568.5 5422.3 5438.8 5455.1 5458.7 5476.7 5987.8 6112.3 6163.0 6206.7 6222.8 6544.6 6634.6 6649.8 6653.0 6679.4 6757.7 6759.5 6764.7 6771.7 6772.5 6139.7 6272.2 6287.4 6309.2 6310.0 6770.4 6857.2 6880.3 6919.2 6928.4 6313.8 6385.5 6568.9 6617.3 6641.5 5193.7 5914.2 6320.5 6720.8 6730.2 6690.5 6702.9 6703.3 6705.3 6712.3 6396.2 6464.7 6477.9 6556.9 6559.1 5343.5 5347.1 5356.5 5379.9 5396.9 4767.0 4768.9 4790.0 4792.3 4824.5 4956.5 6196.1 6236.3 6281.2 6384.1 6652.3 6721.0 6721.4 6740.2 6744.9 6263.4 6288.2 6292.3 6316.2 6344.9 5750.9 5802.0 5948.0 5965.2 5971.0 6826.2 6876.4 6902.8 6929.0 6936.7 6771.8 6789.3 6805.3 6810.0 6810.4 6257.7 6732.6 6913.0 6973.4 7004.4 5390.7 6448.2 6647.9 6667.6 6692.4 6690.6 6775.3 6823.2 6827.9 6834.5 6291.7 6397.2 6397.4 6573.3 6615.7 5433.9 6468.5 6487.6 6507.4 6539.2 5887.2 6034.0 6428.3 6430.2 6466.1 6263.2 6583.1 6605.5 6609.7 6711.0 6227.1 6236.2 6286.1 6356.0 6356.9 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:44369.43 Median:179514.26 stddev:75732.18 (42.2%) stddev-sans-first:75873.68 08:05:57 INFO - PID 1638 | Values: 709.6 770.6 800.3 1151.7 1155.7 37918.8 38535.4 38541.4 38554.4 38579.2 39209.6 39245.4 39509.4 39583.2 39734.8 7762.4 7881.9 8454.4 8721.8 8778.7 8627.4 8714.8 8730.0 8745.5 8751.9 8640.2 8653.7 8738.6 8740.2 8765.1 8661.6 8692.4 8710.0 8713.8 8723.0 8383.9 8428.2 8450.1 8455.5 8459.7 38485.2 38631.6 38638.0 38805.8 38843.8 3567.6 3568.7 3604.9 3604.9 3608.4 22975.9 31473.7 31747.5 31811.8 31861.4 2716.7 3159.8 3197.7 3197.7 3206.8 252975.0 258307.0 266068.0 299794.0 300628.0 41560.8 45592.5 47417.5 47677.3 47826.0 47934.6 48239.0 48343.3 48415.0 48517.0 13731.7 13846.0 13852.6 13854.6 13855.9 11443.8 11457.4 11462.7 11485.0 11511.9 13559.9 13655.0 13663.1 13699.8 13703.5 5448.3 5604.8 5948.5 5956.7 6001.7 1006.2 1014.3 1014.3 1048.0 1057.2 19949.0 23516.4 24482.6 24580.8 24899.5 1031.5 1104.7 1110.2 1151.3 1152.3 10360.0 11079.9 12129.0 12642.9 12738.9 324619.0 325812.0 325897.0 326379.0 326966.0 54144.5 54400.5 54576.0 54577.0 54724.5 1448.8 1496.1 1525.5 1526.6 1530.3 24464.4 24587.5 24703.3 24718.1 24781.5 39147.6 50037.7 50785.7 50842.0 51106.7 260698.0 260804.0 260843.0 261567.0 261775.0 29533.0 30099.8 34377.7 34399.8 34945.0 35303.0 44279.1 44766.1 45345.5 45623.3 30887.7 30958.1 31141.8 31384.9 31434.8 30298.0 31056.5 31138.8 31270.0 31578.0 36784.9 37581.1 38230.2 39099.0 39112.8 31919.5 32168.7 32390.4 32649.5 32852.0 19347.5 23618.9 24862.6 25165.6 25209.6 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:37087.23 Median:22207.44 stddev:98984.00 (445.7%) stddev-sans-first:99223.40 08:05:57 INFO - PID 1638 | Values: 425.0 432.4 435.8 456.1 459.8 16913.9 18452.9 21652.8 22005.8 22213.7 21607.8 22056.9 22201.2 22391.0 23001.5 5744.6 6129.2 6343.0 6344.2 6353.8 5513.0 5788.8 5969.6 6296.8 6300.0 5567.8 6018.8 6163.9 6262.8 6279.7 5690.7 5816.1 6186.6 6195.2 6279.2 5279.8 5494.4 5514.2 5562.6 5578.0 21680.7 27053.3 27216.5 27469.9 27484.2 2254.4 2285.6 2308.9 2322.2 2329.7 13501.1 14394.9 17463.9 17765.5 18283.7 2187.1 2195.0 2198.0 2215.5 2216.6 148736.0 166427.0 169234.0 170395.0 170847.0 12882.9 12954.8 12960.6 13095.8 13136.1 16640.7 16792.7 16851.9 16904.2 16916.0 8791.3 9090.7 9132.5 9287.0 9297.5 8630.4 8717.1 8722.8 8876.0 8906.3 7950.2 8063.9 8067.7 8114.2 8122.8 2017.7 2166.3 2172.0 2173.8 2177.2 954.7 983.9 993.2 1028.3 1029.2 15494.0 21006.8 21860.9 21942.9 22050.8 1010.6 1012.4 1040.6 1043.3 1050.9 11089.6 13058.5 13465.2 13674.6 14213.9 571211.0 578041.0 582209.0 593459.0 594642.0 123010.0 125611.4 127179.0 134697.3 135874.3 1183.8 1200.5 1252.8 1254.4 1259.1 22063.8 22392.1 22682.1 22737.3 22763.8 58012.1 58558.0 58986.7 59561.0 60301.4 82582.6 83011.6 83645.0 83842.7 83981.0 8876.8 8953.2 8976.9 8996.0 9057.7 11811.5 11901.6 12660.6 13582.3 14317.5 10711.4 10877.7 11404.7 11774.7 11920.5 11007.0 11361.0 11453.3 11501.6 11810.7 11828.9 12095.9 12126.2 12149.0 12291.0 8076.8 8722.1 8986.5 9155.7 9171.1 11717.1 11767.8 11905.4 11934.0 12148.5 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7297.00 Median:3374.70 stddev:4678.15 (138.6%) stddev-sans-first:4670.27 08:05:57 INFO - PID 1638 | Values: 1398.9 1421.9 1435.8 1452.4 1460.1 11675.4 11968.5 12229.6 12230.3 12342.2 11964.9 12046.8 12207.1 12217.7 12238.1 2572.7 2583.6 2586.2 2588.7 2588.8 2513.2 2569.7 2572.9 2576.6 2577.7 2528.1 2553.5 2570.5 2579.4 2580.7 2509.7 2531.7 2550.2 2559.2 2562.0 2111.5 2169.8 2524.6 2527.3 2529.4 11790.6 12114.2 12342.6 12366.9 12373.8 5961.8 6723.8 6832.4 7006.6 7008.3 3398.5 4177.1 4358.0 4466.1 4478.5 1257.0 1276.3 1305.9 1306.8 1309.4 17060.4 17079.8 17190.1 17191.7 17224.9 5138.3 5316.1 5677.7 5839.1 5907.2 12491.6 12578.6 12606.2 12609.7 12612.6 6778.0 6779.3 6779.6 6788.5 6788.5 5239.5 5351.2 6065.3 6202.7 6253.9 4434.2 4520.3 4530.8 4536.3 4636.6 1303.0 1317.5 1321.8 1335.6 1337.1 793.4 801.9 823.0 824.5 848.7 6219.2 6290.6 6402.6 6476.2 6548.5 589.3 603.9 605.4 607.5 619.0 3350.9 3956.8 4104.1 4538.1 4561.4 15050.4 15174.8 15250.2 15519.5 15519.5 12842.0 15096.5 15414.0 15512.5 15580.6 8725.0 8799.1 8829.8 8907.8 8944.6 7080.0 7219.7 7409.2 7431.3 7445.8 13545.7 13694.1 13851.0 13946.2 14039.2 14094.9 14105.2 14130.6 14216.0 14248.4 9629.1 9715.4 9807.2 9809.7 9846.5 10872.3 10907.0 10979.5 10995.6 11015.1 9222.6 9292.3 9407.3 9419.2 9532.3 9130.5 9131.3 9210.2 9266.8 9285.2 8270.8 8356.6 8373.0 8449.9 8500.4 6044.5 6166.8 6196.9 6337.1 6346.6 5386.6 6150.6 6355.5 6379.4 6395.2 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:5206.19 Median:5791.37 stddev:1635.13 (28.2%) stddev-sans-first:1598.53 08:05:57 INFO - PID 1638 | Values: 346.9 353.6 401.4 404.4 411.9 4903.7 5908.3 6103.1 6175.4 6183.6 4427.4 6080.7 6082.4 6088.0 6114.2 3740.4 3869.5 4652.0 4664.7 4668.4 4480.2 4630.6 4693.5 4696.1 4696.8 4594.2 4604.1 4614.9 4617.0 4630.9 4637.4 4648.3 4671.4 4675.9 4690.4 3686.3 3791.3 4147.5 4155.9 4161.6 5132.3 5410.7 5645.9 5869.2 5885.5 4409.0 5304.5 5322.5 5327.0 5339.8 6322.5 6350.6 6439.0 6496.6 6496.8 4362.9 4366.1 4375.0 4382.5 4384.6 5266.5 5466.0 6274.5 6849.2 6908.1 3586.3 4332.7 4411.6 4423.9 4440.1 4503.0 4504.8 4526.5 4536.8 4559.6 4454.3 4797.4 4899.9 5302.9 5338.0 5632.5 6481.4 6495.3 6512.8 6533.3 1311.7 1533.8 1545.5 1549.9 1554.2 836.3 915.5 966.0 1003.7 1026.5 5188.5 5800.8 5804.0 6140.3 6178.5 5835.7 6733.6 6737.0 6744.5 6766.5 5841.4 6006.5 6067.0 6118.3 6138.8 3090.8 3242.8 3336.6 3485.3 3494.7 5511.3 5568.4 6338.0 6898.5 6970.9 5481.2 5808.7 6972.8 7026.8 7050.5 6770.9 6953.3 6971.4 7010.3 7067.9 5958.9 6001.9 6616.2 6866.9 6933.6 6397.4 6689.6 6703.5 6736.3 6755.3 6046.6 6969.7 6979.0 6993.7 7016.6 3958.9 4078.9 4182.3 4427.6 4440.3 5400.5 6721.3 6772.5 6773.8 6774.2 5338.8 6517.8 6534.4 6536.5 6541.0 5361.7 6210.0 6448.3 6467.5 6521.3 5256.6 5564.6 6376.8 6379.8 6408.6 6411.0 6495.3 6503.9 6534.5 6556.9 5290.2 5781.9 5989.3 6333.3 6398.6 08:05:57 INFO - PID 1638 | 08:05:57 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:22340.20 Median:18537.36 stddev:32101.88 (173.2%) stddev-sans-first:32151.32 08:05:57 INFO - PID 1638 | Values: 834.3 836.1 840.6 871.4 874.4 15999.8 16661.3 16666.4 18560.7 19296.4 17553.0 17907.5 18060.1 18099.3 18304.5 974.5 978.2 982.2 982.8 985.4 987.7 988.4 988.7 989.7 991.4 1036.7 1042.9 1045.6 1045.8 1046.8 1023.2 1024.1 1037.6 1038.3 1040.7 674.1 690.4 734.3 747.7 748.8 16798.0 16860.7 16870.2 17032.8 17058.5 17155.5 17174.5 17433.4 17480.8 17586.0 12237.9 14056.1 14308.1 14363.5 14367.4 3418.9 3489.3 3492.0 3494.3 3500.4 133372.0 134294.0 134937.0 137140.0 137206.3 12883.0 13045.8 13101.7 13268.6 13304.0 25623.9 25757.2 25826.5 25870.4 25933.2 7524.9 7528.4 7547.5 7641.2 7647.0 3891.2 3962.1 3976.0 3981.7 3991.6 4231.7 4287.8 4343.8 4458.2 4744.5 834.4 966.7 991.1 995.3 997.6 548.6 641.3 647.7 668.5 685.3 10807.2 11093.3 11595.8 12005.1 12054.6 619.9 640.0 640.7 674.1 684.8 4999.3 5206.9 5383.7 5623.3 5685.9 104033.5 105301.9 108874.5 112035.0 112414.0 90105.5 93120.0 95453.5 97674.0 98518.0 80530.0 80706.6 80923.6 81076.0 83354.0 12371.3 12809.5 12815.7 12827.6 12845.3 39937.8 41148.8 42027.8 42344.8 42617.1 53710.7 53880.5 54322.9 54692.2 54899.5 15402.7 15499.3 15549.9 15582.8 16330.3 15420.6 17950.6 18514.0 18696.7 18800.4 16924.5 17062.2 17076.6 17220.3 17259.7 16505.3 17079.2 17134.5 17300.5 17409.7 16375.7 16430.5 16908.3 16948.8 17188.5 10382.9 10450.6 11567.1 11925.4 11994.1 11470.2 13209.8 13254.5 13296.5 13358.7 08:05:57 INFO - PID 1638 | -------- Summary: end -------- 08:05:57 INFO - PID 1638 | 08:05:58 INFO - TEST-INFO | 1638: exit 0 08:05:58 INFO - TEST-OK | dromaeo_css | took 1115452ms 08:05:58 INFO - TEST-START | kraken 08:05:58 INFO - operating with platform_type : mac_ 08:05:58 INFO - Initialising browser for kraken test... 08:05:58 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpZd5vfE/profile http://localhost:49236/getInfo.html) 08:06:01 INFO - PID 1649 | 2017-04-24 08:06:01.395 plugin-container[1650:10209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933b, name = 'com.apple.tsm.portname' 08:06:01 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:01 INFO - PID 1649 | 2017-04-24 08:06:01.398 plugin-container[1650:10209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 08:06:01 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:01 INFO - PID 1649 | 2017-04-24 08:06:01.398 plugin-container[1650:10209] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:01 INFO - PID 1649 | __metrics Screen width/height:1600/1200 08:06:01 INFO - PID 1649 | colorDepth:24 08:06:01 INFO - PID 1649 | Browser inner width/height: 1024/689 08:06:01 INFO - PID 1649 | __metrics 08:06:01 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 08:06:02 INFO - TEST-INFO | 1649: exit 0 08:06:02 INFO - Browser initialized. 08:06:02 INFO - Running cycle 1/1 for kraken test... 08:06:02 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpZd5vfE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:04 INFO - PID 1651 | 2017-04-24 08:06:04.994 plugin-container[1652:10332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 08:06:04 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:05 INFO - PID 1651 | 2017-04-24 08:06:04.995 plugin-container[1652:10332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 08:06:05 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:05 INFO - PID 1651 | 2017-04-24 08:06:04.995 plugin-container[1652:10332] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:14 INFO - PID 1651 | RSS: Main: 237391872 08:06:14 INFO - PID 1651 | 08:06:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:18 INFO - PID 1651 | RSS: Main: 249663488 08:06:18 INFO - PID 1651 | 08:06:21 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:06:21 INFO - PID 1651 | RSS: Main: 257626112 08:06:21 INFO - PID 1651 | 08:06:25 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:06:25 INFO - PID 1651 | RSS: Main: 260550656 08:06:25 INFO - PID 1651 | 08:06:27 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:06:28 INFO - PID 1651 | RSS: Main: 261255168 08:06:28 INFO - PID 1651 | 08:06:30 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:30 INFO - PID 1651 | RSS: Main: 263172096 08:06:30 INFO - PID 1651 | 08:06:33 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:34 INFO - PID 1651 | RSS: Main: 269320192 08:06:34 INFO - PID 1651 | 08:06:37 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:38 INFO - PID 1651 | RSS: Main: 269373440 08:06:38 INFO - PID 1651 | 08:06:41 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:06:41 INFO - PID 1651 | RSS: Main: 269504512 08:06:41 INFO - PID 1651 | 08:06:43 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:43 INFO - PID 1651 | RSS: Main: 269217792 08:06:43 INFO - PID 1651 | 08:06:45 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:46 INFO - PID 1651 | RSS: Main: 269496320 08:06:46 INFO - PID 1651 | 08:06:48 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:48 INFO - PID 1651 | RSS: Main: 268800000 08:06:48 INFO - PID 1651 | 08:06:51 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:52 INFO - PID 1651 | RSS: Main: 268881920 08:06:52 INFO - PID 1651 | 08:06:55 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:56 INFO - PID 1651 | RSS: Main: 269103104 08:06:56 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:06:58 INFO - PID 1651 | RSS: Main: 270643200 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | __start_tp_report 08:06:58 INFO - PID 1651 | _x_x_mozilla_page_load 08:06:58 INFO - PID 1651 | _x_x_mozilla_page_load_details 08:06:58 INFO - PID 1651 | |i|pagename|runs| 08:06:58 INFO - PID 1651 | |0;ai-astar;103;116;116;115;116;111;115;116;117;115 08:06:58 INFO - PID 1651 | |1;audio-beat-detection;135;114;104;175;147;147;109;126;149;99 08:06:58 INFO - PID 1651 | |2;audio-dft;196;203;207;225;221;205;194;200;259;261 08:06:58 INFO - PID 1651 | |3;audio-fft;78;59;56;87;85;83;81;77;79;58 08:06:58 INFO - PID 1651 | |4;audio-oscillator;96;73;89;71;69;73;93;66;70;91 08:06:58 INFO - PID 1651 | |5;imaging-gaussian-blur;91;105;136;90;91;90;105;89;79;138 08:06:58 INFO - PID 1651 | |6;imaging-darkroom;108;99;98;98;99;99;98;99;115;138 08:06:58 INFO - PID 1651 | |7;imaging-desaturate;92;94;93;90;95;90;91;109;91;90 08:06:58 INFO - PID 1651 | |8;json-parse-financial;51;51;50;51;52;51;50;52;48;51 08:06:58 INFO - PID 1651 | |9;json-stringify-tinderbox;59;59;55;61;63;58;55;58;58;56 08:06:58 INFO - PID 1651 | |10;stanford-crypto-aes;84;85;83;82;82;83;83;88;85;82 08:06:58 INFO - PID 1651 | |11;stanford-crypto-ccm;156;132;154;153;151;136;156;157;232;173 08:06:58 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;186;188;212;201;189;185;185;189;181;188 08:06:58 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;68;70;68;67;70;66;69;69;69;69 08:06:58 INFO - PID 1651 | __end_tp_report 08:06:58 INFO - PID 1651 | __start_cc_report 08:06:58 INFO - PID 1651 | _x_x_mozilla_cycle_collect,982 08:06:58 INFO - PID 1651 | __end_cc_report 08:06:58 INFO - PID 1651 | __startTimestamp1493046418448__endTimestamp 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | ------- Summary: start ------- 08:06:58 INFO - PID 1651 | Number of tests: 14 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:114.00 Median:116.00 stddev:4.19 (3.6%) stddev-sans-first:1.72 08:06:58 INFO - PID 1651 | Values: 103.0 116.0 116.0 115.0 116.0 111.0 115.0 116.0 117.0 115.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:147.00 stddev:24.35 (16.6%) stddev-sans-first:25.77 08:06:58 INFO - PID 1651 | Values: 135.0 114.0 104.0 175.0 147.0 147.0 109.0 126.0 149.0 99.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:217.10 Median:214.00 stddev:24.67 (11.5%) stddev-sans-first:24.96 08:06:58 INFO - PID 1651 | Values: 196.0 203.0 207.0 225.0 221.0 205.0 194.0 200.0 259.0 261.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:74.30 Median:80.00 stddev:11.90 (14.9%) stddev-sans-first:12.54 08:06:58 INFO - PID 1651 | Values: 78.0 59.0 56.0 87.0 85.0 83.0 81.0 77.0 79.0 58.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:81.00 stddev:11.62 (14.3%) stddev-sans-first:10.59 08:06:58 INFO - PID 1651 | Values: 96.0 73.0 89.0 71.0 69.0 73.0 93.0 66.0 70.0 91.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:89.50 stddev:20.26 (22.6%) stddev-sans-first:21.14 08:06:58 INFO - PID 1651 | Values: 91.0 105.0 136.0 90.0 91.0 90.0 105.0 89.0 79.0 138.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:98.50 stddev:12.86 (13.1%) stddev-sans-first:13.60 08:06:58 INFO - PID 1651 | Values: 108.0 99.0 98.0 98.0 99.0 99.0 98.0 99.0 115.0 138.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:91.50 stddev:5.72 (6.3%) stddev-sans-first:6.04 08:06:58 INFO - PID 1651 | Values: 92.0 94.0 93.0 90.0 95.0 90.0 91.0 109.0 91.0 90.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.16 (2.3%) stddev-sans-first:1.22 08:06:58 INFO - PID 1651 | Values: 51.0 51.0 50.0 51.0 52.0 51.0 50.0 52.0 48.0 51.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.50 stddev:2.53 (4.3%) stddev-sans-first:2.67 08:06:58 INFO - PID 1651 | Values: 59.0 59.0 55.0 61.0 63.0 58.0 55.0 58.0 58.0 56.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:1.89 (2.3%) stddev-sans-first:2.00 08:06:58 INFO - PID 1651 | Values: 84.0 85.0 83.0 82.0 82.0 83.0 83.0 88.0 85.0 82.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:160.00 Median:156.00 stddev:27.73 (17.8%) stddev-sans-first:29.37 08:06:58 INFO - PID 1651 | Values: 156.0 132.0 154.0 153.0 151.0 136.0 156.0 157.0 232.0 173.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.40 Median:188.50 stddev:9.19 (4.9%) stddev-sans-first:9.61 08:06:58 INFO - PID 1651 | Values: 186.0 188.0 212.0 201.0 189.0 185.0 185.0 189.0 181.0 188.0 08:06:58 INFO - PID 1651 | 08:06:58 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.27 (1.8%) stddev-sans-first:1.33 08:06:58 INFO - PID 1651 | Values: 68.0 70.0 68.0 67.0 70.0 66.0 69.0 69.0 69.0 69.0 08:06:58 INFO - PID 1651 | -------- Summary: end -------- 08:06:58 INFO - PID 1651 | 08:06:59 INFO - TEST-INFO | 1651: exit 0 08:06:59 INFO - TEST-OK | kraken | took 60921ms 08:06:59 INFO - SUITE-END | took 1176s 08:06:59 INFO - Completed test suite (00:19:36) 08:06:59 INFO - javascript benchmark 08:06:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7905.539386610183, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.736981041514, 3615.529981102456, 3621.34815733168, 3660.5790334111584, 3662.4689420034097, 4724.24412094065, 6111.865232675502, 6143.477804386627, 6197.535184861136, 6305.716242769075, 6173.876522469548, 6179.412955769206, 6204.813855584329, 6242.625442473443, 6287.025511045784, 5144.614153938451, 5468.453154684539, 5494.450554944504, 5530.198121272413, 5584.804531841386, 5404.000259951902, 5493.23094766733, 5587.38538760736, 5621.718914054301, 5664.54683625309, 5384.461553844623, 5422.864428389283, 5425.0, 5521.978433989725, 5558.388577256519, 5444.40111587725, 5501.229827824108, 5502.0, 5509.834704958857, 5568.49883510482, 5422.349318081816, 5438.755256013489, 5455.1271796512365, 5458.699771512565, 5476.726163691839, 5987.760489580412, 6112.266528016622, 6162.96918515409, 6206.72069756862, 6222.782202622887, 6544.607323560554, 6634.568753031038, 6649.767258145942, 6653.0, 6679.398854103106, 6757.6822519608695, 6759.459243260528, 6764.729410823561, 6771.72913083476, 6772.525923185379, 6139.693015349215, 6272.18461599989, 6287.371262873722, 6309.2428908530355, 6310.0, 6770.356816102462, 6857.211420686585, 6880.346367095118, 6919.238883722786, 6928.44572434204, 6313.810585682437, 6385.48916086712, 6568.86862262752, 6617.272100068989, 6641.468682505388, 5193.662411943212, 5914.172015917775, 6320.494360451153, 6720.798376048726, 6730.158730158731, 6690.498212634072, 6702.932970670328, 6703.29615390377, 6705.295943925915, 6712.261651218362, 6396.168498095218, 6464.741410343628, 6477.8704425912165, 6556.901646475307, 6559.147310849655, 5343.545798607084, 5347.064263753905, 5356.517913387814, 5379.919301210485, 5396.91904621431, 4766.95233047672, 4768.856934291976, 4789.976050119727, 4792.305115758196, 4824.517548245148, 4956.529129732669, 6196.132541444202, 6236.251649801962, 6281.183446151971, 6384.138141350858, 6652.301508341651, 6720.966395167993, 6721.395074443323, 6740.157480314961, 6744.932550674529, 6263.373662633791, 6288.245410550763, 6292.307846136921, 6316.178896743394, 6344.936550634527, 5750.913736293959, 5802.0, 5948.0, 5965.164876917235, 5970.955082860482, 6826.180858297036, 6876.381125698711, 6902.758403455855, 6929.0, 6936.687849046704, 6771.762988295583, 6789.321067893368, 6805.251422343637, 6810.046593477016, 6810.353016463428, 6257.7184026718, 6732.562383445061, 6913.0, 6973.407260382722, 7004.3696067354185, 5390.703511306916, 6448.193975753031, 6647.933520664731, 6667.566608170453, 6692.397684208445, 6690.565113267622, 6775.322467753383, 6823.249442561215, 6827.931720682928, 6834.453243740588, 6291.653959032297, 6397.200349956255, 6397.360263973565, 6573.276939536743, 6615.66921653925, 5433.945660543344, 6468.482521398183, 6487.578307410004, 6507.446867016357, 6539.182602174728, 5887.1757953885635, 6034.0, 6428.260750013808, 6430.196225471816, 6466.06242094903, 6263.154474145932, 6583.078369028436, 6605.47156227491, 6609.669516524251, 6710.966445167743, 6227.06594010902, 6236.18929539157, 6286.057091436322, 6356.014817703079, 6356.904646430215], "value": 6080.880107525354, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.6168069242606, 770.6300975531744, 800.2637573432442, 1151.6890439581314, 1155.6995181252883, 37918.81040594797, 38535.42196867049, 38541.421878671805, 38554.421683674766, 38579.22841543167, 39209.60790392095, 39245.41131883024, 39509.40735888957, 39583.20833583327, 39734.80132599333, 7762.379009679226, 7881.921180788176, 8454.365922555802, 8721.7819554511, 8778.6927457539, 8627.396082274243, 8714.782130446727, 8729.956350218241, 8745.518996455192, 8751.912480875206, 8640.2223799858, 8653.69712060078, 8738.563071846414, 8740.213380795727, 8765.079666635007, 8661.566921653925, 8692.43499172555, 8709.95645021777, 8713.7821554461, 8723.0, 8383.874241886377, 8428.157184281585, 8450.112738162466, 8455.53494557799, 8459.66161353545, 38485.23029539421, 38631.613683863085, 38638.0, 38805.80597096997, 38843.8057809712, 3567.571891373026, 3568.6966607838367, 3604.9098772530633, 3604.9279014419567, 3608.386574282378, 22975.885120574458, 31473.685263147305, 31747.52378714321, 31811.84094079538, 31861.362772744415, 2716.7419095185924, 3159.8104113753247, 3197.6802319767835, 3197.6962188592047, 3206.839658017113, 252975.0, 258307.0, 266068.0, 299794.0, 300628.0, 41560.79219603883, 45592.54407455949, 47417.525824742, 47677.284840727414, 47826.0, 47934.56196314116, 48239.0, 48343.274850877264, 48415.03169936581, 48517.0, 13731.725365492634, 13845.961552883575, 13852.584422467342, 13854.584362469142, 13855.86144138566, 11443.828342574869, 11457.427128643534, 11462.713432164095, 11485.023772979222, 11511.942440287912, 13559.864401356057, 13655.04414690982, 13663.111897726814, 13699.794503082461, 13703.45186192561, 5448.318960129984, 5604.8318550443555, 5948.464638182584, 5956.672383018976, 6001.669908155006, 1006.2201793609864, 1014.300132908291, 1014.325473560089, 1048.0305717211702, 1057.2387880725864, 19949.0, 23516.412089697893, 24482.632760508608, 24580.754192457847, 24899.502009960062, 1031.5306535526317, 1104.6685994201707, 1110.1895616200059, 1151.2919554474106, 1152.2855829385835, 10360.0, 11079.892010799016, 12129.02967762577, 12642.873571264354, 12738.936305318413, 324619.0, 325812.0, 325897.0, 326379.0, 326966.0, 54144.45855541473, 54400.45599543954, 54576.0, 54577.0, 54724.45275547194, 1448.833384160814, 1496.132243298906, 1525.5270866031565, 1526.6183454136467, 1530.3113598880548, 24464.388390290384, 24587.508249834544, 24703.258902232963, 24718.13486527963, 24781.504369912862, 39147.608523914394, 50037.74905627388, 50785.73035674138, 50842.0, 51106.74446627743, 260698.0, 260804.0, 260843.0, 261567.0, 261775.0, 29533.0, 30099.849500752356, 34377.65622343744, 34399.828000860834, 34945.0, 35303.0, 44279.11441771082, 44766.10467790691, 45345.54654453413, 45623.31565026461, 30887.69112308848, 30958.0712578623, 31141.8442907784, 31384.901528446393, 31434.842825785723, 30298.0, 31056.534151987285, 31138.844305778326, 31270.0, 31578.0, 36784.89645310645, 37581.06047348838, 38230.2353952925, 39099.02252443712, 39112.80443597764, 31919.521207182377, 32168.67831321657, 32390.35219295648, 32649.510257346636, 32852.014439566854, 19347.548933829738, 23618.882771038087, 24862.63255520964, 25165.609267119595, 25209.621855671812], "value": 17586.811708631954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.96600271978207, 432.44862799930087, 435.83656128951645, 456.0855484753072, 459.80228501744244, 16913.915430422847, 18452.892826430423, 21652.783472165273, 22005.779942200574, 22213.66679499807, 21607.783922160772, 22056.8897155514, 22201.22295719646, 22391.0, 23001.539969200607, 5744.621290890177, 6129.203203583528, 6343.048542718583, 6344.206974128234, 6353.777617783378, 5513.0, 5788.768449262025, 5969.641821490724, 6296.842578935518, 6300.0, 5567.832965011056, 6018.7893423730175, 6163.907541386883, 6262.780802671908, 6279.654618995954, 5690.687012214326, 5816.1275808628625, 6186.56694031418, 6195.2255968004, 6279.183706118199, 5279.815206467793, 5494.36814766303, 5514.200440936042, 5562.610617256793, 5578.0, 21680.674789878165, 27053.323666908484, 27216.455670886473, 27469.862650686817, 27484.175474735788, 2254.402583315423, 2285.5543169082034, 2308.8845557722216, 2322.2336628912417, 2329.650552417151, 13501.122427042212, 14394.928025359912, 17463.86484878479, 17765.46703598881, 18283.72574411385, 2187.1360812478983, 2195.0, 2198.0, 2215.523662412589, 2216.612092883755, 148736.0, 166427.0, 169234.0, 170395.0, 170847.0, 12882.935585322013, 12954.80567791484, 12960.611181664564, 13095.803562946563, 13136.146150500186, 16640.6671866562, 16792.748108778134, 16851.915740421464, 16904.239309231114, 16915.985040897587, 8791.252743516872, 9090.727278181665, 9132.543372831331, 9286.95356523213, 9297.488638124833, 8630.39587228888, 8717.12828717136, 8722.825543489094, 8875.955620221857, 8906.332025098143, 7950.165232650604, 8063.879041814377, 8067.677292908218, 8114.188581141839, 8122.837543249102, 2017.7074324222906, 2166.2851259084464, 2171.9891400542897, 2173.7608863025052, 2177.194438057929, 954.656323723459, 983.9458829764288, 993.24513369838, 1028.290479569095, 1029.156092004549, 15494.0, 21006.78993210079, 21860.89069554642, 21942.89028554847, 22050.779492205194, 1010.6210171185805, 1012.4330374990029, 1040.6201736366172, 1043.2905624175633, 1050.8791488978866, 11089.5564177432, 13058.49827269857, 13465.182200403016, 13674.589762307147, 14213.933954953212, 571211.0, 578041.0, 582209.0, 593459.0, 594642.0, 123010.0, 125611.3719431397, 127179.0, 134697.32651336875, 135874.3206283982, 1183.7573297473998, 1200.543793358518, 1252.8183413405004, 1254.3853511779162, 1259.0934527140444, 22063.779362206173, 22392.104315827186, 22682.092716291823, 22737.31788046361, 22763.772362276166, 58012.12981805361, 58558.0, 58986.705066474395, 59561.0, 60301.39698602958, 82582.58708706418, 83011.5849420749, 83645.0, 83842.74235886344, 83981.0, 8876.822463550821, 8953.194212520904, 8976.922769267469, 8996.0, 9057.728268151966, 11811.527538898348, 11901.583444579399, 12660.556880509139, 13582.320883955961, 14317.498887538886, 10711.41087240178, 10877.728056798644, 11404.714882128013, 11774.705632359259, 11920.52317907274, 11007.009369156815, 11361.0, 11453.255538389978, 11501.597444089417, 11810.704732381759, 11828.881711182778, 12095.879041209475, 12126.211796233569, 12149.0, 12291.016718662664, 8076.83846323082, 8722.084181160886, 8986.460812351279, 9155.679551215675, 9171.082891711043, 11717.06263498935, 11767.823482647596, 11905.40472976365, 11933.985611222795, 12148.514059437877], "value": 10616.719737576232, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.8810951069158, 1421.850705675904, 1435.7702767557194, 1452.3537026023416, 1460.0874453466583, 11675.41622918855, 11968.461419236133, 12229.633111006662, 12230.266184028953, 12342.19775714578, 11964.880351196485, 12046.81929771052, 12207.145499815017, 12217.694557636041, 12238.143329966884, 2572.691277046757, 2583.560794664902, 2586.249987503631, 2588.676415448069, 2588.8317259378173, 2513.2334637935423, 2569.6530968319225, 2572.909948151815, 2576.5877459606468, 2577.6520169777027, 2528.05198050731, 2553.4893021395796, 2570.4602033572974, 2579.3551612096976, 2580.703219129796, 2509.736477669846, 2531.7215106338194, 2550.2094350751327, 2559.2341284513814, 2561.9615705764427, 2111.5354621983292, 2169.783021697833, 2524.6213068039756, 2527.2923581397054, 2529.3929456930387, 11790.646280611509, 12114.21257618252, 12342.568010119603, 12366.948809351215, 12373.752524949541, 5961.837441698871, 6723.823330917119, 6832.3509266620085, 7006.6496675166545, 7008.299170082951, 3398.490226466025, 4177.10192308652, 4357.9976605380625, 4466.062126953344, 4478.484974227973, 1257.0195247706804, 1276.2725246609436, 1305.8563558008611, 1306.751717173734, 1309.3584143769485, 17060.402885899057, 17079.82920170807, 17190.1404929753, 17191.656166876717, 17224.913875430542, 5138.306328645585, 5316.122839731401, 5677.716114194356, 5839.124131380242, 5907.172995780594, 12491.562795302121, 12578.55975040869, 12606.180598261084, 12609.747805044031, 12612.621621351374, 6778.0, 6779.2881747416795, 6779.62712050832, 6788.49086318528, 6788.524803263823, 5239.5284424401225, 5351.170568561879, 6065.332813390612, 6202.658853763086, 6253.937460625427, 4434.224010798098, 4520.254158063948, 4530.77346132692, 4536.319552067151, 4636.559526844944, 1303.0422639360063, 1317.4730107956893, 1321.7885138377812, 1335.5659410691565, 1337.1041402260314, 793.4326956226325, 801.8933871257627, 822.9753107406788, 824.4640983360863, 848.6562942008496, 6219.160413344141, 6290.622562646256, 6402.647854368054, 6476.222853257545, 6548.476121910236, 589.345826132992, 603.8973374526341, 605.3855336833118, 607.471499795181, 618.9566730328924, 3350.9162270942934, 3956.8219430125714, 4104.076582768913, 4538.069695712371, 4561.407017087758, 15050.397984080515, 15174.772378414333, 15250.237488125771, 15519.45681901128, 15519.45681901128, 12841.972642188603, 15096.54710358691, 15414.0, 15512.457064002705, 15580.610484737972, 8724.956375218084, 8799.076097009849, 8829.823403532022, 8907.821843563223, 8944.597493112826, 7080.04419403374, 7219.711211551479, 7409.184989651027, 7431.256874312742, 7445.7766267012075, 13545.729085418434, 13694.109882857583, 13851.0, 13946.16323020622, 14039.227842468354, 14094.9428792843, 14105.224212667992, 14130.646733831736, 14216.0, 14248.35882385316, 9629.133377996013, 9715.417074975525, 9807.21542276602, 9809.656662017082, 9846.507674616098, 10872.347659140476, 10907.0, 10979.505922233679, 10995.560177592806, 11015.118790496581, 9222.584983675884, 9292.349535532718, 9407.294452916196, 9419.246460283299, 9532.332736708364, 9130.543472826199, 9131.315151363542, 9210.171084602418, 9266.814663706553, 9285.164335209864, 8270.793230169294, 8356.623951922056, 8373.0, 8449.915500844912, 8500.44747091437, 6044.516438684806, 6166.845828854314, 6196.876062478816, 6337.112804207507, 6346.587471814502, 5386.649867758583, 6150.554619664285, 6355.459785918249, 6379.425851673372, 6395.232572091379], "value": 5438.297765776228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9496922946173, 353.60043151239097, 401.36784564311216, 404.43379269023364, 411.92791261529226, 4903.730294833783, 5908.320543137541, 6103.145559621651, 6175.4252665570275, 6183.6289822610615, 4427.380166776646, 6080.662254304057, 6082.361352058026, 6088.0, 6114.205153330072, 3740.3641380965164, 3869.4776205212356, 4651.953480465194, 4664.696794708333, 4668.439787225538, 4480.19356515827, 4630.560096790799, 4693.507181745918, 4696.131215725085, 4696.765161741916, 4594.218982772936, 4604.1482325769675, 4614.884627884313, 4616.97691511542, 4630.884227894296, 4637.397138372024, 4648.328429927918, 4671.416072990876, 4675.906481870344, 4690.366800481926, 3686.3227231609553, 3791.317562838688, 4147.502299724022, 4155.898686847988, 4161.56303588125, 5132.3327967364, 5410.729463526808, 5645.887082258373, 5869.178315035856, 5885.528617845539, 4408.955910440886, 5304.469553044703, 5322.5209731124, 5326.97336513315, 5339.759710813023, 6322.530603315397, 6350.618962862243, 6439.0, 6496.577722448026, 6496.772612958571, 4362.90927268183, 4366.104948485585, 4375.037491751809, 4382.517923028464, 4384.649228061748, 5266.526012658841, 5466.0, 6274.498040156822, 6849.1780986281465, 6908.1364829396825, 3586.2648157128247, 4332.718373305725, 4411.632393957883, 4423.92075724409, 4440.134173836135, 4502.996166705784, 4504.752238626907, 4526.524714904954, 4536.754306618245, 4559.603095693663, 4454.331850222427, 4797.368894575861, 4899.902001960012, 5302.893942121136, 5337.97157080307, 5632.52123569493, 6481.4166724994975, 6495.3179916109075, 6512.772052978123, 6533.314002029813, 1311.731095125497, 1533.7852700621922, 1545.5054382597461, 1549.9225038748018, 1554.1529866222936, 836.2891542189091, 915.4507295622707, 966.0436168193438, 1003.6738060130341, 1026.5483187397522, 5188.45521220274, 5800.8259752207505, 5804.04233301509, 6140.293866205354, 6178.474829639441, 5835.708214589254, 6733.6296503692765, 6737.0, 6744.494162937799, 6766.458683305324, 5841.4450627190345, 6006.5495087868585, 6067.029275315928, 6118.265808103056, 6138.78514252008, 3090.752739780812, 3242.773005889565, 3336.59960804705, 3485.337785820686, 3494.7029502492064, 5511.311086114236, 5568.44315568448, 6338.0, 6898.517103802786, 6970.895436568456, 5481.177823326453, 5808.651480911159, 6972.755953541703, 7026.789196324118, 7050.506464547432, 6770.93229067703, 6953.33943275388, 6971.407430368476, 7010.334018268256, 7067.893981590178, 5958.910616340845, 6001.879962400815, 6616.172978377703, 6866.931330686829, 6933.618650974245, 6397.424231818973, 6689.632070235989, 6703.491714364229, 6736.292689267556, 6755.344940489612, 6046.637201767908, 6969.6515174242095, 6978.965105174645, 6993.685284162123, 7016.6491675415, 3958.9208215836097, 4078.898027549335, 4182.2681030820095, 4427.5572442755465, 4440.333949907411, 5400.540954018796, 6721.327867213239, 6772.458203343622, 6773.762918297836, 6774.153230846145, 5338.759755811076, 6517.804465866032, 6534.386245501837, 6536.477081833346, 6541.0, 5361.705106219039, 6210.0, 6448.29068802422, 6467.482601391972, 6521.250056243593, 5256.579473642176, 5564.638298510584, 6376.776812811529, 6379.819733349345, 6408.58344207625, 6411.0, 6495.317991610813, 6503.869922601427, 6534.542582019213, 6556.868862622626, 5290.1800220965815, 5781.913271301018, 5989.293051480307, 6333.334999825136, 6398.584092034003], "value": 4693.521037020412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.2866848844242, 836.105367257035, 840.5755093677692, 871.424859592669, 874.4010352908257, 15999.760003599955, 16661.250243739032, 16666.416675416363, 18560.721589176173, 19296.421107366765, 17553.0, 17907.462776116736, 18060.096995150256, 18099.27602895886, 18304.542386440346, 974.4543055888707, 978.2027647467291, 982.2093214961952, 982.8083523712879, 985.4136788610801, 987.6543209876558, 988.4020167798486, 988.7132731507854, 989.7278248481689, 991.3952488981715, 1036.7200855768938, 1042.8696412948382, 1045.592219034577, 1045.8222102242637, 1046.7592453735645, 1023.1814548361281, 1024.0578667625728, 1037.5953378182514, 1038.3458421194637, 1040.745017470717, 674.1472037872096, 690.3959035843637, 734.3280897978343, 747.6710247491086, 748.7791101625033, 16797.99212047269, 16860.66278674432, 16870.240839162267, 17032.82967170325, 17058.48824535266, 17155.485335439957, 17174.484765457055, 17433.38983135597, 17480.82519174805, 17586.032768197743, 12237.938810305892, 14056.086354387035, 14308.069975451666, 14363.497277595234, 14367.425302987867, 3418.931621367559, 3489.3021395720957, 3492.0396890854963, 3494.318607871466, 3500.3699334119847, 133372.0, 134294.0, 134937.0, 137140.0, 137206.3139684305, 12883.0, 13045.804312935314, 13101.737965240642, 13268.601941941757, 13304.0, 25623.871880640476, 25757.227283181535, 25826.483470330488, 25870.353241169123, 25933.22200333993, 7524.887126693104, 7528.397728181732, 7547.50941188821, 7641.235876412315, 7647.0, 3891.1633998690418, 3962.108525581779, 3976.005998500375, 3981.7411868228473, 3991.640752332304, 4231.682623803227, 4287.828486860553, 4343.804528796211, 4458.219811532968, 4744.501827308152, 834.4117397234935, 966.6997887840843, 991.0683957080322, 995.2535598301274, 997.6159178716247, 548.5940404100936, 641.323403808986, 647.7376662451715, 668.5220067651652, 685.3420716112488, 10807.243492955575, 11093.278936869077, 11595.76808463826, 12005.09961752872, 12054.638360849189, 619.9380061993764, 639.964801935898, 640.7148818775601, 674.0967104080555, 684.8116767888871, 4999.250112483084, 5206.906549624546, 5383.7308134593895, 5623.297087864017, 5685.857853553612, 104033.47983260186, 105301.94698053075, 108874.45562772294, 112035.0, 112414.0, 90105.54947225354, 93120.0, 95453.5227323859, 97674.0, 98518.0, 80530.0, 80706.59646701728, 80923.5953820239, 81076.0, 83354.0, 12371.257724536557, 12809.487620495449, 12815.743685126059, 12827.615171544869, 12845.293508856728, 39937.80031099826, 41148.79425602853, 42027.7898610505, 42344.82413818914, 42617.1476570473, 53710.73144634252, 53880.46119538754, 54322.91354172974, 54692.17961730657, 54899.451005491035, 15402.691946161238, 15499.302531385889, 15549.922250388676, 15582.84417155814, 16330.346786128897, 15420.614484637525, 17950.640987180446, 18514.0, 18696.719549207046, 18800.435986920413, 16924.492265232064, 17062.232199551298, 17076.573085672957, 17220.311187552357, 17259.654806904044, 16505.257263422936, 17079.231434585723, 17134.543563796717, 17300.48098557045, 17409.738853916948, 16375.67248655044, 16430.507084787474, 16908.32366705318, 16948.830511694727, 17188.484345469657, 10382.857885632726, 10450.634227801991, 11567.132465065322, 11925.4037298133, 11994.100442466675, 11470.19708620422, 13209.801852972021, 13254.53609123676, 13296.534621288209, 13358.666033349244], "value": 8422.713523461354, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 116.0, 115.0, 116.0, 111.0, 115.0, 116.0, 117.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 114.0, 104.0, 175.0, 147.0, 147.0, 109.0, 126.0, 149.0, 99.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 203.0, 207.0, 225.0, 221.0, 205.0, 194.0, 200.0, 259.0, 261.0], "value": 217.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 56.0, 87.0, 85.0, 83.0, 81.0, 77.0, 79.0, 58.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 73.0, 89.0, 71.0, 69.0, 73.0, 93.0, 66.0, 70.0, 91.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 105.0, 136.0, 90.0, 91.0, 90.0, 105.0, 89.0, 79.0, 138.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 99.0, 98.0, 98.0, 99.0, 99.0, 98.0, 99.0, 115.0, 138.0], "value": 105.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 90.0, 95.0, 90.0, 91.0, 109.0, 91.0, 90.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 52.0, 51.0, 50.0, 52.0, 48.0, 51.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 55.0, 61.0, 63.0, 58.0, 55.0, 58.0, 58.0, 56.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 82.0, 82.0, 83.0, 83.0, 88.0, 85.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 154.0, 153.0, 151.0, 136.0, 156.0, 157.0, 232.0, 173.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 212.0, 201.0, 189.0, 185.0, 185.0, 189.0, 181.0, 188.0], "value": 190.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 67.0, 70.0, 66.0, 69.0, 69.0, 69.0, 69.0], "value": 68.5, "unit": "score"}]}]} 08:06:59 INFO - Return code: 0 08:06:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:06:59 ERROR - # TBPL SUCCESS # 08:06:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:59 INFO - 2017-04-24 08:06:59.763 screenresolution[1656:10722] starting screenresolution argv=screenresolution get 08:06:59 INFO - 2017-04-24 08:06:59.766 screenresolution[1656:10722] Display 0: 1600x1200x32@60 08:06:59 INFO - 2017-04-24 08:06:59.772 screenresolution[1657:10726] starting screenresolution argv=screenresolution list 08:06:59 INFO - Available Modes on Display 0 08:06:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:00 INFO - Intel Iris: 08:07:00 INFO - Chipset Model: Intel Iris 08:07:00 INFO - Type: GPU 08:07:00 INFO - Bus: Built-In 08:07:00 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:00 INFO - Vendor: Intel (0x8086) 08:07:00 INFO - Device ID: 0x0a2e 08:07:00 INFO - Revision ID: 0x0009 08:07:00 INFO - Displays: 08:07:00 INFO - Display: 08:07:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:00 INFO - Display Serial Number: 1600x1200 60 08:07:00 INFO - Main Display: Yes 08:07:00 INFO - Mirror: Off 08:07:00 INFO - Online: Yes 08:07:00 INFO - Rotation: Supported 08:07:00 INFO - Return code: 0 08:07:00 INFO - Running post-action listener: _resource_record_post_action 08:07:00 INFO - [mozharness: 2017-04-24 15:07:00.015691Z] Finished run-tests step (success) 08:07:00 INFO - Running post-run listener: _resource_record_post_run 08:07:00 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38279680; Write bytes: 512466944; Read time: 252; Write time: 1632 08:07:00 INFO - TinderboxPrint: CPU usage
54.1% 08:07:00 INFO - TinderboxPrint: I/O read bytes / time
38,279,680 / 252 08:07:00 INFO - TinderboxPrint: I/O write bytes / time
512,466,944 / 1,632 08:07:00 INFO - TinderboxPrint: CPU idle
2,197.0 (45.9%) 08:07:00 INFO - TinderboxPrint: CPU system
966.5 (20.2%) 08:07:00 INFO - TinderboxPrint: CPU user
1,626.3 (34.0%) 08:07:00 INFO - TinderboxPrint: Swap in / out
245,911,552 / 0 08:07:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209357312; Write bytes: 209018880; Read time: 16026; Write time: 458 08:07:00 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35224064; Write bytes: 302112768; Read time: 227; Write time: 1169 08:07:00 INFO - Running post-run listener: _upload_blobber_files 08:07:00 INFO - Blob upload gear active. 08:07:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:00 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 08:07:00 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'] 08:07:00 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 08:07:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:02 INFO - (blobuploader) - INFO - Done attempting. 08:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:03 INFO - (blobuploader) - INFO - Done attempting. 08:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:07:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:04 INFO - (blobuploader) - INFO - Done attempting. 08:07:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:06 INFO - (blobuploader) - INFO - Done attempting. 08:07:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:06 INFO - Return code: 0 08:07:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3600393224c74ec0a530cb19dd2f146b6ed0b5dc3e6b19dddfb227c3a82c0da796fd0e19bc017e65d927fb5c662b09fd81e0679d3ecc600a8db86113f0586fba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2f368a5e53e294e6795718b994133a9ae50caea72a4453925946978e65a9c0fb6e3cf5f1e590dcd37a698440bfdf208e62d12ca7f83a02433512cb728ab092d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb711a6325c4d95acd969220bf9dd7925ee62d2e251b4c611815704816aaddc1cd45963abf29253ec70d224b9769398f760dcfbdc308cccae8a7e278d45cf87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8396364cd4ede4784403d079a867c63ec49ffe1ad8ab55d26c9d2b0fcf397b1f6fefaaf71d565b41c6e875a930f8625ae2d2117cf17a75e7ec9e1711d4b5a169"} 08:07:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:06 INFO - Contents: 08:07:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3600393224c74ec0a530cb19dd2f146b6ed0b5dc3e6b19dddfb227c3a82c0da796fd0e19bc017e65d927fb5c662b09fd81e0679d3ecc600a8db86113f0586fba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2f368a5e53e294e6795718b994133a9ae50caea72a4453925946978e65a9c0fb6e3cf5f1e590dcd37a698440bfdf208e62d12ca7f83a02433512cb728ab092d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb711a6325c4d95acd969220bf9dd7925ee62d2e251b4c611815704816aaddc1cd45963abf29253ec70d224b9769398f760dcfbdc308cccae8a7e278d45cf87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8396364cd4ede4784403d079a867c63ec49ffe1ad8ab55d26c9d2b0fcf397b1f6fefaaf71d565b41c6e875a930f8625ae2d2117cf17a75e7ec9e1711d4b5a169"} 08:07:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:06 INFO - Copying logs to upload dir... 08:07:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.814764 ========= master_lag: 0.58 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-24 08:07:06.517548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:06.520668) ========= 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.ZxL7mTewQM/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.9mVNkeslqf/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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/3600393224c74ec0a530cb19dd2f146b6ed0b5dc3e6b19dddfb227c3a82c0da796fd0e19bc017e65d927fb5c662b09fd81e0679d3ecc600a8db86113f0586fba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2f368a5e53e294e6795718b994133a9ae50caea72a4453925946978e65a9c0fb6e3cf5f1e590dcd37a698440bfdf208e62d12ca7f83a02433512cb728ab092d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb711a6325c4d95acd969220bf9dd7925ee62d2e251b4c611815704816aaddc1cd45963abf29253ec70d224b9769398f760dcfbdc308cccae8a7e278d45cf87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8396364cd4ede4784403d079a867c63ec49ffe1ad8ab55d26c9d2b0fcf397b1f6fefaaf71d565b41c6e875a930f8625ae2d2117cf17a75e7ec9e1711d4b5a169"} build_url:https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010972 build_url: 'https://queue.taskcluster.net/v1/task/OWEhljtCSSm958xjiBNNvA/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/3600393224c74ec0a530cb19dd2f146b6ed0b5dc3e6b19dddfb227c3a82c0da796fd0e19bc017e65d927fb5c662b09fd81e0679d3ecc600a8db86113f0586fba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2f368a5e53e294e6795718b994133a9ae50caea72a4453925946978e65a9c0fb6e3cf5f1e590dcd37a698440bfdf208e62d12ca7f83a02433512cb728ab092d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb711a6325c4d95acd969220bf9dd7925ee62d2e251b4c611815704816aaddc1cd45963abf29253ec70d224b9769398f760dcfbdc308cccae8a7e278d45cf87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8396364cd4ede4784403d079a867c63ec49ffe1ad8ab55d26c9d2b0fcf397b1f6fefaaf71d565b41c6e875a930f8625ae2d2117cf17a75e7ec9e1711d4b5a169"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:06.555107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:06.555445) ========= 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.ZxL7mTewQM/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.9mVNkeslqf/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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.005009 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 08:07:06.604436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 08:07:06.604793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 08:07:06.605164) ========= ========= Total master_lag: 0.73 =========