builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0340 starttime: 1491818225.22 results: success (0) buildid: 20170410013249 builduid: 9037b1d14835470293e2ddd78644b890 revision: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.224085) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.224571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.224963) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.250464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.250883) ========= 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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-10 02:57:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.02M=0.001s 2017-04-10 02:57:05 (8.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.397464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.397783) ========= 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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.021021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:05.446673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 02:57:05.447056) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 50cb1ce431d7d2acb0f483bd77395a3b96068d2c --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 50cb1ce431d7d2acb0f483bd77395a3b96068d2c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dQoWe5w0f6/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.5FcYp0C2tI/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-10 02:57:05,544 truncating revision to first 12 chars 2017-04-10 02:57:05,544 Setting DEBUG logging. 2017-04-10 02:57:05,545 attempt 1/10 2017-04-10 02:57:05,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/50cb1ce431d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 02:57:06,373 unpacking tar archive at: mozilla-central-50cb1ce431d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 02:57:06.565855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:06.566187) ========= script_repo_revision: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:06.566586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:06.566873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 02:57:06.588952) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-10 02:57:06.589375) ========= /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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:57:06 INFO - MultiFileLogger online at 20170410 02:57:06 in /builds/slave/test 02:57:06 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 02:57:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:06 INFO - {'append_to_log': False, 02:57:06 INFO - 'base_work_dir': '/builds/slave/test', 02:57:06 INFO - 'blob_upload_branch': 'Firefox', 02:57:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:06 INFO - 'branch': 'Firefox', 02:57:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:06 INFO - 'config_files': ('talos/mac_config.py',), 02:57:06 INFO - 'default_actions': ('clobber', 02:57:06 INFO - 'read-buildbot-config', 02:57:06 INFO - 'download-and-extract', 02:57:06 INFO - 'populate-webroot', 02:57:06 INFO - 'create-virtualenv', 02:57:06 INFO - 'install', 02:57:06 INFO - 'run-tests'), 02:57:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:06 INFO - 'download_minidump_stackwalk': True, 02:57:06 INFO - 'download_symbols': 'ondemand', 02:57:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:57:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:57:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:57:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:57:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:06 INFO - 'gecko_profile': False, 02:57:06 INFO - 'gecko_profile_interval': 0, 02:57:06 INFO - 'installer_path': 'installer.exe', 02:57:06 INFO - 'log_level': 'info', 02:57:06 INFO - 'log_name': 'talos', 02:57:06 INFO - 'log_to_console': True, 02:57:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:57:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:57:06 INFO - 'opt_config_files': (), 02:57:06 INFO - 'pip_index': False, 02:57:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:57:06 INFO - 'cmd': ('bash', 02:57:06 INFO - '-c', 02:57:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:57:06 INFO - 'enabled': True, 02:57:06 INFO - 'halt_on_failure': False, 02:57:06 INFO - 'name': 'check_screen_resolution'},), 02:57:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:57:06 INFO - 'cmd': ('bash', 02:57:06 INFO - '-c', 02:57:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:57:06 INFO - 'enabled': True, 02:57:06 INFO - 'halt_on_failure': False, 02:57:06 INFO - 'name': 'check_screen_resolution'},), 02:57:06 INFO - 'run_cmd_checks_enabled': True, 02:57:06 INFO - 'suite': 'dromaeojs-e10s', 02:57:06 INFO - 'system_bits': '32', 02:57:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:06 INFO - 'title': 't-yosemite-r7-0340', 02:57:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:06 INFO - 'use_talos_json': True, 02:57:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:06 INFO - 'work_dir': 'build'} 02:57:06 INFO - [mozharness: 2017-04-10 09:57:06.809880Z] Running clobber step. 02:57:06 INFO - Running pre-action listener: _resource_record_pre_action 02:57:06 INFO - Running main action method: clobber 02:57:06 INFO - rmtree: /builds/slave/test/build 02:57:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:08 INFO - Running post-action listener: _resource_record_post_action 02:57:08 INFO - [mozharness: 2017-04-10 09:57:08.532687Z] Finished clobber step (success) 02:57:08 INFO - [mozharness: 2017-04-10 09:57:08.532902Z] Running read-buildbot-config step. 02:57:08 INFO - Running pre-action listener: _resource_record_pre_action 02:57:08 INFO - Running main action method: read_buildbot_config 02:57:08 INFO - Using buildbot properties: 02:57:08 INFO - { 02:57:08 INFO - "project": "", 02:57:08 INFO - "product": "firefox", 02:57:08 INFO - "script_repo_revision": "production", 02:57:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:57:08 INFO - "repository": "", 02:57:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:57:08 INFO - "buildid": "20170410013249", 02:57:08 INFO - "pgo_build": "False", 02:57:08 INFO - "basedir": "/builds/slave/test", 02:57:08 INFO - "buildnumber": 141, 02:57:08 INFO - "slavename": "t-yosemite-r7-0340", 02:57:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:57:08 INFO - "platform": "yosemite_r7", 02:57:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:57:08 INFO - "branch": "mozilla-central", 02:57:08 INFO - "repo_path": "mozilla-central", 02:57:08 INFO - "revision": "50cb1ce431d7d2acb0f483bd77395a3b96068d2c", 02:57:08 INFO - "stage_platform": "macosx64", 02:57:08 INFO - "builduid": "9037b1d14835470293e2ddd78644b890", 02:57:08 INFO - "slavebuilddir": "test" 02:57:08 INFO - } 02:57:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:57:08 INFO - Running post-action listener: _resource_record_post_action 02:57:08 INFO - [mozharness: 2017-04-10 09:57:08.537934Z] Finished read-buildbot-config step (success) 02:57:08 INFO - [mozharness: 2017-04-10 09:57:08.538054Z] Running download-and-extract step. 02:57:08 INFO - Running pre-action listener: _resource_record_pre_action 02:57:08 INFO - Running main action method: download_and_extract 02:57:08 INFO - mkdir: /builds/slave/test/build/tests 02:57:08 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')]} 02:57:08 INFO - trying https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:57:08 INFO - Downloading https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/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 02:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/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 02:57:09 INFO - Downloaded 1325 bytes. 02:57:09 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:57:09 INFO - Using the following test package requirements: 02:57:09 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:57:09 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:57:09 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:57:09 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:57:09 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'jsshell-mac.zip'], 02:57:09 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:57:09 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:57:09 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:57:09 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:57:09 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:57:09 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:57:09 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:57:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:57:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:57:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:57:09 INFO - Fetch https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:57:10 INFO - Expected file size: 52525328 02:57:10 INFO - Obtained file size: 52525328 02:57:26 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 02:57:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:57:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:57:26 INFO - Fetch https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:57:28 INFO - Expected file size: 52525328 02:57:28 INFO - Obtained file size: 52525328 02:57:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:57:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:57:43 INFO - Fetch https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:57:44 INFO - Expected file size: 14405596 02:57:44 INFO - Obtained file size: 14405596 02:57:45 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')]} 02:57:45 INFO - trying https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:57:45 INFO - Downloading https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/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 02:57:47 INFO - Downloaded 70965145 bytes. 02:57:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:57:47 INFO - mkdir: /builds/slave/test/properties 02:57:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:47 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:47 INFO - Contents: 02:57:47 INFO - build_url:https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:57:48 INFO - Running post-action listener: _resource_record_post_action 02:57:48 INFO - Running post-action listener: set_extra_try_arguments 02:57:48 INFO - [mozharness: 2017-04-10 09:57:48.185506Z] Finished download-and-extract step (success) 02:57:48 INFO - [mozharness: 2017-04-10 09:57:48.185631Z] Running populate-webroot step. 02:57:48 INFO - Running pre-action listener: _resource_record_pre_action 02:57:48 INFO - Running main action method: populate_webroot 02:57:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:48 INFO - '--tppagecycles', 02:57:48 INFO - '7'], 02:57:48 INFO - 'tests': ['tsvgm']}}, 02:57:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['damp', 'tps']}, 02:57:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'tests': ['damp', 'tps']}, 02:57:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['dromaeo_dom']}, 02:57:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['basic_compositor_video']}, 02:57:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:57:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['a11yr', 02:57:48 INFO - 'ts_paint', 02:57:48 INFO - 'tpaint', 02:57:48 INFO - 'sessionrestore', 02:57:48 INFO - 'sessionrestore_no_auto_restore', 02:57:48 INFO - 'tabpaint']}, 02:57:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:48 INFO - 'ts_paint', 02:57:48 INFO - 'tpaint', 02:57:48 INFO - 'sessionrestore', 02:57:48 INFO - 'sessionrestore_no_auto_restore', 02:57:48 INFO - 'tabpaint']}, 02:57:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:48 INFO - 'ts_paint', 02:57:48 INFO - 'tpaint', 02:57:48 INFO - 'sessionrestore', 02:57:48 INFO - 'sessionrestore_no_auto_restore', 02:57:48 INFO - 'tabpaint']}, 02:57:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:48 INFO - 'ts_paint', 02:57:48 INFO - 'tpaint', 02:57:48 INFO - 'sessionrestore', 02:57:48 INFO - 'sessionrestore_no_auto_restore', 02:57:48 INFO - 'tabpaint']}, 02:57:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['a11yr', 02:57:48 INFO - 'ts_paint', 02:57:48 INFO - 'tpaint', 02:57:48 INFO - 'sessionrestore', 02:57:48 INFO - 'sessionrestore_no_auto_restore', 02:57:48 INFO - 'tabpaint']}, 02:57:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['a11yr', 02:57:48 INFO - 'ts_paint', 02:57:48 INFO - 'tpaint', 02:57:48 INFO - 'sessionrestore', 02:57:48 INFO - 'sessionrestore_no_auto_restore', 02:57:48 INFO - 'tabpaint']}, 02:57:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['tsvgx', 02:57:48 INFO - 'tsvgr_opacity', 02:57:48 INFO - 'tart', 02:57:48 INFO - 'tscrollx', 02:57:48 INFO - 'cart', 02:57:48 INFO - 'tsvg_static']}, 02:57:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:48 INFO - 'tsvgr_opacity', 02:57:48 INFO - 'tart', 02:57:48 INFO - 'tscrollx', 02:57:48 INFO - 'cart', 02:57:48 INFO - 'tsvg_static']}, 02:57:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'talos_options': ['--disable-e10s'], 02:57:48 INFO - 'tests': ['tp5o']}, 02:57:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'talos_options': ['--disable-e10s', 02:57:48 INFO - '--xperf_path', 02:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:48 INFO - 'tests': ['tp5n']}, 02:57:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:48 INFO - 'talos_options': ['--xperf_path', 02:57:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:48 INFO - 'tests': ['tp5n']}}, 02:57:48 INFO - 'talos.zip': {'path': '', 02:57:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:48 INFO - Running post-action listener: _resource_record_post_action 02:57:48 INFO - [mozharness: 2017-04-10 09:57:48.204315Z] Finished populate-webroot step (success) 02:57:48 INFO - [mozharness: 2017-04-10 09:57:48.204455Z] Running create-virtualenv step. 02:57:48 INFO - Running pre-action listener: _resource_record_pre_action 02:57:48 INFO - Running main action method: create_virtualenv 02:57:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:48 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 02:57:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:48 INFO - Using real prefix '/tools/python27' 02:57:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:51 INFO - Installing pip.................done. 02:57:51 INFO - Return code: 0 02:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:52 INFO - Reading from file tmpfile_stdout 02:57:52 INFO - Output received: 02:57:52 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) 02:57:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:57:52 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 02:57:52 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 02:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:52 INFO - 'HOME': '/Users/cltbld', 02:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PAGER': '/bin/cat', 02:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:57:52 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - 'XPC_FLAGS': '0x0', 02:57:52 INFO - 'XPC_SERVICE_NAME': '0', 02:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:52 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 02:57:52 INFO - Cleaning up... 02:57:52 INFO - Return code: 0 02:57:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:57:52 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 02:57:52 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 02:57:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:57:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:52 INFO - 'HOME': '/Users/cltbld', 02:57:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PAGER': '/bin/cat', 02:57:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:57:52 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:57:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - 'XPC_FLAGS': '0x0', 02:57:52 INFO - 'XPC_SERVICE_NAME': '0', 02:57:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:52 INFO - Downloading/unpacking psutil>=3.1.1 02:57:52 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 02:57:52 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 02:57:52 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 02:57:52 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 02:57:52 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 02:57:52 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 02:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:56 INFO - Installing collected packages: psutil 02:57:56 INFO - Running setup.py install for psutil 02:57:56 INFO - building 'psutil._psutil_osx' extension 02:57:56 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 02:57:56 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 02:57:56 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 02:57:56 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 02:57:56 INFO - building 'psutil._psutil_posix' extension 02:57:56 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 02:57:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:57:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:57:56 INFO - ^ 02:57:56 INFO - 1 warning generated. 02:57:56 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 02:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:57 INFO - Successfully installed psutil 02:57:57 INFO - Cleaning up... 02:57:57 INFO - Return code: 0 02:57:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:57 INFO - 'HOME': '/Users/cltbld', 02:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:57 INFO - 'LOGNAME': 'cltbld', 02:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:57 INFO - 'MOZ_NO_REMOTE': '1', 02:57:57 INFO - 'NO_EM_RESTART': '1', 02:57:57 INFO - 'PAGER': '/bin/cat', 02:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:57 INFO - 'PWD': '/builds/slave/test', 02:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:57 INFO - 'SHELL': '/bin/bash', 02:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:57:57 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:57 INFO - 'USER': 'cltbld', 02:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:57 INFO - 'XPC_FLAGS': '0x0', 02:57:57 INFO - 'XPC_SERVICE_NAME': '0', 02:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:58:00 INFO - Installing collected packages: mozsystemmonitor 02:58:00 INFO - Running setup.py install for mozsystemmonitor 02:58:00 INFO - Successfully installed mozsystemmonitor 02:58:00 INFO - Cleaning up... 02:58:00 INFO - Return code: 0 02:58:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:58:00 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')]} 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 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')]} 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:00 INFO - 'HOME': '/Users/cltbld', 02:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:00 INFO - 'LOGNAME': 'cltbld', 02:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:00 INFO - 'MOZ_NO_REMOTE': '1', 02:58:00 INFO - 'NO_EM_RESTART': '1', 02:58:00 INFO - 'PAGER': '/bin/cat', 02:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:00 INFO - 'PWD': '/builds/slave/test', 02:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:00 INFO - 'SHELL': '/bin/bash', 02:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:00 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:00 INFO - 'USER': 'cltbld', 02:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:00 INFO - 'XPC_FLAGS': '0x0', 02:58:00 INFO - 'XPC_SERVICE_NAME': '0', 02:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:00 INFO - Downloading/unpacking jsonschema==2.5.1 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:03 INFO - warning: no files found matching '*.txt' 02:58:03 INFO - no previously-included directories found matching 'build' 02:58:03 INFO - no previously-included directories found matching 'dist' 02:58:03 INFO - no previously-included directories found matching '.git*' 02:58:03 INFO - Installing collected packages: jsonschema, functools32 02:58:03 INFO - Running setup.py install for functools32 02:58:03 INFO - warning: no files found matching '*.txt' 02:58:03 INFO - no previously-included directories found matching 'build' 02:58:03 INFO - no previously-included directories found matching 'dist' 02:58:03 INFO - no previously-included directories found matching '.git*' 02:58:03 INFO - Successfully installed jsonschema functools32 02:58:03 INFO - Cleaning up... 02:58:03 INFO - Return code: 0 02:58:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:04 INFO - 'HOME': '/Users/cltbld', 02:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:04 INFO - 'LOGNAME': 'cltbld', 02:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:04 INFO - 'MOZ_NO_REMOTE': '1', 02:58:04 INFO - 'NO_EM_RESTART': '1', 02:58:04 INFO - 'PAGER': '/bin/cat', 02:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:04 INFO - 'PWD': '/builds/slave/test', 02:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:04 INFO - 'SHELL': '/bin/bash', 02:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:04 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:04 INFO - 'USER': 'cltbld', 02:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:04 INFO - 'XPC_FLAGS': '0x0', 02:58:04 INFO - 'XPC_SERVICE_NAME': '0', 02:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:58:04 INFO - Cleaning up... 02:58:04 INFO - Return code: 0 02:58:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:05 INFO - 'HOME': '/Users/cltbld', 02:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:05 INFO - 'LOGNAME': 'cltbld', 02:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:05 INFO - 'MOZ_NO_REMOTE': '1', 02:58:05 INFO - 'NO_EM_RESTART': '1', 02:58:05 INFO - 'PAGER': '/bin/cat', 02:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:05 INFO - 'PWD': '/builds/slave/test', 02:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:05 INFO - 'SHELL': '/bin/bash', 02:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:05 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:05 INFO - 'USER': 'cltbld', 02:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:05 INFO - 'XPC_FLAGS': '0x0', 02:58:05 INFO - 'XPC_SERVICE_NAME': '0', 02:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:05 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 02:58:05 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 02:58:05 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 02:58:05 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 02:58:05 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 02:58:05 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 02:58:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:09 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 02:58:09 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 02:58:09 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 02:58:09 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 02:58:09 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 02:58:09 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 02:58:09 INFO - Downloading docopt-0.6.1.tar.gz 02:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:09 INFO - Running setup.py install for blobuploader 02:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:10 INFO - Running setup.py install for requests 02:58:10 INFO - Running setup.py install for docopt 02:58:10 INFO - Successfully installed blobuploader requests docopt 02:58:10 INFO - Cleaning up... 02:58:10 INFO - Return code: 0 02:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:10 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')]} 02:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:10 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')]} 02:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:10 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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:10 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 02:58:10 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 02:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:10 INFO - 'HOME': '/Users/cltbld', 02:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:10 INFO - 'LOGNAME': 'cltbld', 02:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:10 INFO - 'MOZ_NO_REMOTE': '1', 02:58:10 INFO - 'NO_EM_RESTART': '1', 02:58:10 INFO - 'PAGER': '/bin/cat', 02:58:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:10 INFO - 'PWD': '/builds/slave/test', 02:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:10 INFO - 'SHELL': '/bin/bash', 02:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:10 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:10 INFO - 'USER': 'cltbld', 02:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:10 INFO - 'XPC_FLAGS': '0x0', 02:58:10 INFO - 'XPC_SERVICE_NAME': '0', 02:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9gy1WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-cgBrTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-x0wG83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-zEsHU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-yoKe7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-QJKJtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-5i6SPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-3N7135-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-kLDCEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:11 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-mjloC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-vf7x8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-jQ4NV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-jU5UhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-76HO0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-p7IS8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-dcYbwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:12 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-jOT_yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:12 INFO - Running setup.py install for manifestparser 02:58:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:12 INFO - Running setup.py install for mozcrash 02:58:13 INFO - Running setup.py install for mozdebug 02:58:13 INFO - Running setup.py install for mozdevice 02:58:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Running setup.py install for mozfile 02:58:13 INFO - Running setup.py install for mozhttpd 02:58:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Running setup.py install for mozinfo 02:58:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Running setup.py install for mozInstall 02:58:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:13 INFO - Running setup.py install for mozleak 02:58:14 INFO - Running setup.py install for mozlog 02:58:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:14 INFO - Running setup.py install for moznetwork 02:58:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:14 INFO - Running setup.py install for mozprocess 02:58:14 INFO - Running setup.py install for mozprofile 02:58:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:14 INFO - Running setup.py install for mozrunner 02:58:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:14 INFO - Running setup.py install for mozscreenshot 02:58:15 INFO - Running setup.py install for moztest 02:58:15 INFO - Running setup.py install for mozversion 02:58:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:15 INFO - Cleaning up... 02:58:15 INFO - Return code: 0 02:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:15 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 02:58:15 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 02:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:15 INFO - 'HOME': '/Users/cltbld', 02:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:15 INFO - 'LOGNAME': 'cltbld', 02:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:15 INFO - 'MOZ_NO_REMOTE': '1', 02:58:15 INFO - 'NO_EM_RESTART': '1', 02:58:15 INFO - 'PAGER': '/bin/cat', 02:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:15 INFO - 'PWD': '/builds/slave/test', 02:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:15 INFO - 'SHELL': '/bin/bash', 02:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:15 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:15 INFO - 'USER': 'cltbld', 02:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:15 INFO - 'XPC_FLAGS': '0x0', 02:58:15 INFO - 'XPC_SERVICE_NAME': '0', 02:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-b09UsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:15 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)) 02:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-EawEvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:15 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)) 02:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-cjaS8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:15 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)) 02:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:15 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-JXyaYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-aJEjuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-epObCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-jGV3Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-a4QBCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-MOh0SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-7jHiR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-J6GlxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-ddkZU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Q3OUZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:16 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)) 02:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:16 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Cqs1D9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:17 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)) 02:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:17 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-UzzYnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:17 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)) 02:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:17 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-rcNuWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:17 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)) 02:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:17 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-JER3NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:17 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)) 02:58:17 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)) 02:58:17 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)) 02:58:17 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)) 02:58:17 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)) 02:58:17 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)) 02:58:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:17 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 02:58:17 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 02:58:17 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 02:58:17 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 02:58:17 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 02:58:17 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 02:58:19 INFO - Downloading blessings-1.6.tar.gz 02:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:20 INFO - Installing collected packages: blessings 02:58:20 INFO - Running setup.py install for blessings 02:58:20 INFO - Successfully installed blessings 02:58:20 INFO - Cleaning up... 02:58:20 INFO - Return code: 0 02:58:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:20 INFO - Reading from file tmpfile_stdout 02:58:20 INFO - Current package versions: 02:58:20 INFO - blessings == 1.6 02:58:20 INFO - blobuploader == 1.2.4 02:58:20 INFO - docopt == 0.6.1 02:58:20 INFO - functools32 == 3.2.3-2 02:58:20 INFO - jsonschema == 2.5.1 02:58:20 INFO - manifestparser == 1.1 02:58:20 INFO - mozInstall == 1.12 02:58:20 INFO - mozcrash == 1.0 02:58:20 INFO - mozdebug == 0.1 02:58:20 INFO - mozdevice == 0.50 02:58:20 INFO - mozfile == 1.2 02:58:20 INFO - mozhttpd == 0.7 02:58:20 INFO - mozinfo == 0.9 02:58:20 INFO - mozleak == 0.1 02:58:20 INFO - mozlog == 3.4 02:58:20 INFO - moznetwork == 0.27 02:58:20 INFO - mozprocess == 0.25 02:58:20 INFO - mozprofile == 0.28 02:58:20 INFO - mozrunner == 6.13 02:58:20 INFO - mozscreenshot == 0.1 02:58:20 INFO - mozsystemmonitor == 0.3 02:58:20 INFO - moztest == 0.8 02:58:20 INFO - mozversion == 1.4 02:58:20 INFO - psutil == 3.1.1 02:58:20 INFO - requests == 1.2.3 02:58:20 INFO - wsgiref == 0.1.2 02:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:20 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')]} 02:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:20 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')]} 02:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:20 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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:20 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 02:58:20 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 02:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:20 INFO - 'HOME': '/Users/cltbld', 02:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:20 INFO - 'LOGNAME': 'cltbld', 02:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:20 INFO - 'MOZ_NO_REMOTE': '1', 02:58:20 INFO - 'NO_EM_RESTART': '1', 02:58:20 INFO - 'PAGER': '/bin/cat', 02:58:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:20 INFO - 'PWD': '/builds/slave/test', 02:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:20 INFO - 'SHELL': '/bin/bash', 02:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:20 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:20 INFO - 'USER': 'cltbld', 02:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:20 INFO - 'XPC_FLAGS': '0x0', 02:58:20 INFO - 'XPC_SERVICE_NAME': '0', 02:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 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)) 02:58:20 INFO - Cleaning up... 02:58:20 INFO - Return code: 0 02:58:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:20 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')]} 02:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:20 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')]} 02:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:20 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 0x1075fdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107600768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00c73620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, '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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 02:58:20 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 02:58:20 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 02:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:20 INFO - 'HOME': '/Users/cltbld', 02:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:20 INFO - 'LOGNAME': 'cltbld', 02:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:20 INFO - 'MOZ_NO_REMOTE': '1', 02:58:20 INFO - 'NO_EM_RESTART': '1', 02:58:20 INFO - 'PAGER': '/bin/cat', 02:58:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:20 INFO - 'PWD': '/builds/slave/test', 02:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:20 INFO - 'SHELL': '/bin/bash', 02:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:20 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:20 INFO - 'USER': 'cltbld', 02:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:20 INFO - 'XPC_FLAGS': '0x0', 02:58:20 INFO - 'XPC_SERVICE_NAME': '0', 02:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:21 INFO - Cleaning up... 02:58:21 INFO - Return code: 0 02:58:21 INFO - Running post-action listener: _resource_record_post_action 02:58:21 INFO - Running post-action listener: _start_resource_monitoring 02:58:21 INFO - Starting resource monitoring. 02:58:21 INFO - [mozharness: 2017-04-10 09:58:21.141067Z] Finished create-virtualenv step (success) 02:58:21 INFO - [mozharness: 2017-04-10 09:58:21.142137Z] Running install step. 02:58:21 INFO - Running pre-action listener: _resource_record_pre_action 02:58:21 INFO - Running main action method: install 02:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:21 INFO - Reading from file tmpfile_stdout 02:58:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:21 INFO - Reading from file tmpfile_stdout 02:58:21 INFO - Output received: 02:58:21 INFO - Usage: mozinstall [options] installer 02:58:21 INFO - Options: 02:58:21 INFO - -h, --help show this help message and exit 02:58:21 INFO - -d DEST, --destination=DEST 02:58:21 INFO - Directory to install application into. [default: 02:58:21 INFO - "/builds/slave/test"] 02:58:21 INFO - --app=APP Application being installed. [default: firefox] 02:58:21 INFO - mkdir: /builds/slave/test/build/application 02:58:21 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'] 02:58:21 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 02:58:41 INFO - Reading from file tmpfile_stdout 02:58:41 INFO - Output received: 02:58:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:58:41 INFO - Running post-action listener: _resource_record_post_action 02:58:41 INFO - [mozharness: 2017-04-10 09:58:41.269567Z] Finished install step (success) 02:58:41 INFO - [mozharness: 2017-04-10 09:58:41.269716Z] Running run-tests step. 02:58:41 INFO - Running pre-action listener: _resource_record_pre_action 02:58:41 INFO - Running main action method: run_tests 02:58:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:58:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:58:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:58:41 INFO - 2017-04-10 02:58:41.284 screenresolution[2182:25477] starting screenresolution argv=screenresolution get 02:58:41 INFO - 2017-04-10 02:58:41.287 screenresolution[2182:25477] Display 0: 1600x1200x32@60 02:58:41 INFO - 2017-04-10 02:58:41.292 screenresolution[2183:25481] starting screenresolution argv=screenresolution list 02:58:41 INFO - Available Modes on Display 0 02:58:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:58:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:58:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:58:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:58:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:58:41 INFO - Intel Iris: 02:58:41 INFO - Chipset Model: Intel Iris 02:58:41 INFO - Type: GPU 02:58:41 INFO - Bus: Built-In 02:58:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:58:41 INFO - Vendor: Intel (0x8086) 02:58:41 INFO - Device ID: 0x0a2e 02:58:41 INFO - Revision ID: 0x0009 02:58:41 INFO - Displays: 02:58:41 INFO - Display: 02:58:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:58:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:58:41 INFO - Display Serial Number: 1600x1200 60 02:58:41 INFO - Main Display: Yes 02:58:41 INFO - Mirror: Off 02:58:41 INFO - Online: Yes 02:58:41 INFO - Rotation: Supported 02:58:41 INFO - Return code: 0 02:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:41 INFO - Python 2.7.3 02:58:41 INFO - Return code: 0 02:58:41 INFO - grabbing minidump binary from tooltool 02:58:41 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')]} 02:58:41 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 0x1073dbd30>, '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 0x107302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073d0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:41 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 02:58:41 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 02:58:41 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 02:58:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:41 INFO - Return code: 0 02:58:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:58:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:41 INFO - ENV: RUST_BACKTRACE is now 1 02:58:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:58:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:41 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/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 02:58:41 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/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --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 02:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dQoWe5w0f6/Render', 02:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:41 INFO - 'HOME': '/Users/cltbld', 02:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:41 INFO - 'LOGNAME': 'cltbld', 02:58:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:41 INFO - 'MOZ_NO_REMOTE': '1', 02:58:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:41 INFO - 'NO_EM_RESTART': '1', 02:58:41 INFO - 'PAGER': '/bin/cat', 02:58:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:41 INFO - 'PWD': '/builds/slave/test', 02:58:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:41 INFO - 'RUST_BACKTRACE': '1', 02:58:41 INFO - 'SHELL': '/bin/bash', 02:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5FcYp0C2tI/Listeners', 02:58:41 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 02:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:41 INFO - 'USER': 'cltbld', 02:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:41 INFO - 'XPC_FLAGS': '0x0', 02:58:41 INFO - 'XPC_SERVICE_NAME': '0', 02:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:41 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/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 02:58:41 INFO - mozversion application_buildid: 20170410013249 02:58:41 INFO - mozversion application_changeset: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c 02:58:41 INFO - mozversion application_display_name: Nightly 02:58:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:41 INFO - mozversion application_name: Firefox 02:58:41 INFO - mozversion application_remotingname: firefox 02:58:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:58:41 INFO - mozversion application_vendor: Mozilla 02:58:41 INFO - mozversion application_version: 55.0a1 02:58:41 INFO - mozversion platform_buildid: 20170410013249 02:58:41 INFO - mozversion platform_changeset: 50cb1ce431d7d2acb0f483bd77395a3b96068d2c 02:58:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:58:41 INFO - mozversion platform_version: 55.0a1 02:58:41 INFO - using testdate: 1491818321 02:58:41 INFO - actual date: 1491818321 02:58:41 INFO - starting webserver on 'localhost:56568' 02:58:41 INFO - SUITE-START | Running 2 tests 02:58:41 INFO - TEST-START | dromaeo_css 02:58:41 INFO - operating with platform_type : mac_ 02:58:41 INFO - Initialising browser for dromaeo_css test... 02:58:41 INFO - TEST-INFO | started process 2193 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpwk3Sn5/profile http://localhost:56568/getInfo.html) 02:58:44 INFO - PID 2193 | 2017-04-10 02:58:44.831 plugin-container[2195:25652] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 02:58:44 INFO - PID 2193 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:44 INFO - PID 2193 | 2017-04-10 02:58:44.833 plugin-container[2195:25652] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9513, name = 'com.apple.CFPasteboardClient' 02:58:44 INFO - PID 2193 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:44 INFO - PID 2193 | 2017-04-10 02:58:44.833 plugin-container[2195:25652] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:44 INFO - PID 2193 | __metrics Screen width/height:1600/1200 02:58:44 INFO - PID 2193 | colorDepth:24 02:58:44 INFO - PID 2193 | Browser inner width/height: 1024/689 02:58:44 INFO - PID 2193 | __metrics 02:58:45 ERROR - PID 2193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 02:58:45 INFO - TEST-INFO | 2193: exit 0 02:58:45 INFO - Browser initialized. 02:58:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:45 INFO - TEST-INFO | started process 2196 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpwk3Sn5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:48 INFO - PID 2196 | 2017-04-10 02:58:48.842 plugin-container[2197:25780] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 02:58:48 INFO - PID 2196 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:48 INFO - PID 2196 | 2017-04-10 02:58:48.843 plugin-container[2197:25780] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 02:58:48 INFO - PID 2196 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:48 INFO - PID 2196 | 2017-04-10 02:58:48.843 plugin-container[2197:25780] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:58 INFO - PID 2196 | RSS: Main: 234389504 02:58:58 INFO - PID 2196 | 03:02:02 INFO - PID 2196 | Cycle 1(1): loaded http://localhost:56568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56568/tests/dromaeo/cssquery-ext.html) 03:02:04 INFO - PID 2196 | RSS: Main: 252571648 03:02:04 INFO - PID 2196 | 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | A coding exception was thrown and uncaught in a Task. 03:03:46 INFO - PID 2196 | 03:03:46 ERROR - PID 2196 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:46 INFO - PID 2196 | Full stack: 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | A coding exception was thrown and uncaught in a Task. 03:03:46 INFO - PID 2196 | 03:03:46 ERROR - PID 2196 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:46 INFO - PID 2196 | Full stack: 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | A coding exception was thrown and uncaught in a Task. 03:03:46 INFO - PID 2196 | 03:03:46 ERROR - PID 2196 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:46 INFO - PID 2196 | Full stack: 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | ************************* 03:03:46 INFO - PID 2196 | A coding exception was thrown and uncaught in a Task. 03:03:46 INFO - PID 2196 | 03:03:46 ERROR - PID 2196 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:46 INFO - PID 2196 | Full stack: 03:03:46 INFO - PID 2196 | ************************* 03:05:05 INFO - PID 2196 | Cycle 1(1): loaded http://localhost:56568/tests/dromaeo/cssquery-ext.html (next: http://localhost:56568/tests/dromaeo/cssquery-jquery.html) 03:05:06 INFO - PID 2196 | RSS: Main: 260575232 03:05:06 INFO - PID 2196 | 03:08:08 INFO - PID 2196 | Cycle 1(1): loaded http://localhost:56568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56568/tests/dromaeo/cssquery-mootools.html) 03:08:09 INFO - PID 2196 | RSS: Main: 275345408 03:08:09 INFO - PID 2196 | 03:11:10 INFO - PID 2196 | Cycle 1(1): loaded http://localhost:56568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56568/tests/dromaeo/cssquery-prototype.html) 03:11:11 INFO - PID 2196 | RSS: Main: 268185600 03:11:11 INFO - PID 2196 | 03:14:14 INFO - PID 2196 | Cycle 1(1): loaded http://localhost:56568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56568/tests/dromaeo/cssquery-yui.html) 03:14:15 INFO - PID 2196 | RSS: Main: 278269952 03:14:15 INFO - PID 2196 | 03:17:16 INFO - PID 2196 | Cycle 1(1): loaded http://localhost:56568/tests/dromaeo/cssquery-yui.html (next: http://localhost:56568/tests/dromaeo/cssquery-dojo.html) 03:17:16 INFO - PID 2196 | RSS: Main: 271917056 03:17:16 INFO - PID 2196 | 03:17:16 INFO - PID 2196 | __start_tp_report 03:17:16 INFO - PID 2196 | _x_x_mozilla_page_load 03:17:16 INFO - PID 2196 | _x_x_mozilla_page_load_details 03:17:16 INFO - PID 2196 | |i|pagename|runs| 03:17:16 INFO - PID 2196 | |0;dojo.html;3224.3873664003854;3289.3914625794237;3483.02475306914;3504.474328850672;3625.909352266193;6218.751249950008;6239.220097487814;6277.968610156949;6296.527760417964;6336.493080553556;6201.906971395432;6258.061290806381;6274.4353008229255;6279.623222606635;6280.591761535497;5466.098093814516;5573.6098473106695;5615.943840561604;5667.178259152441;5668.036433806263;4943.788771750926;5508.256385387981;5610.69141197234;5671.461211184931;5757.712114394284;5453.590980676465;5476.91784623231;5498.202760599731;5599.272094627713;5625.987322282008;5517.641353312022;5522.66863988162;5533.142362933751;5587.664740115606;5623.381428042912;5456.7544460499375;5461.344638643349;5463.344398672145;5470.234167216593;5503.449655034505;6053.303870054956;6185.628862268233;6248.656323902183;6267.5299352548745;6272.780452684134;6635.4691624670395;6744.325567443266;6773.593584384904;6777.390034896834;6778.457723382117;6829;6864.519483636147;6872.10662613862;6872.725090996354;6891.37977582015;6273.309935907047;6290.559660823698;6339.334369891188;6352.460040896575;6358.300586935434;6902.758403455855;6984.825379365557;6990.440764738809;7010.614416207056;7093.077899872984;6440.420362167428;6502.122213501211;6540.8364790880605;6702.162229721285;6708.3291670833505;6790.898136527956;6844.349786770249;6857.108575885203;6866.244713081557;6885.070515480346;6507.577007494498;6700.865982680319;6739.359760822714;6768.661566921634;6793.082933803873;6614.470842332602;6658.5671931324305;6694.665266736643;6754.763583274562;6797.2523022467485;5424.972875135599;5429.429909859408;5440.211169380417;5444.945550544444;5455.290812194468;4745.766100813813;4757.215059515211;4777;4787.210110331756;4828.444728856156;6118.862843290023;6343.809685709436;6347.1114044033875;6374.043893416025;6405.967970160119;6886.793396198122;6906.482013848981;6918.135233095863;6921.996310535045;6933.826654333581;6342.746290148435;6465.1595292611655;6472.158619379545;6484.805455836333;6486.481081513468;5833.4749872511675;5917.378675239124;5927.2590926134235;6067.635941843503;6088.208532890696;6807.217170025411;6973.093497845248;7025.121859767529;7035.718571257093;7057.082579264663;6806;6835.521513494008;6841.350071743176;6864.107666003388;6879.793606191823;6858.5199036067;6957.930420695729;7017.193022802239;7025.824354391181;7047.295270472911;6435.581687190318;6512.837179070561;6640.302768209462;6711.194656641234;6714.731410743516;5876.647401155944;6866.896996544956;6869.519133660796;6878.518503704692;6901;6440.355964403522;6490.480761538971;6533.738650454119;6560.540762146604;6620.404163625104;6180.702052568831;6592.472602191909;6629.668516574248;6640.767573134917;6657.966710166418;5764.884702306014;6265.310815810166;6339.207599050119;6384.840378990562;6411.615303081643;6581.045748366556;6682.63245521501;6686.030525573668;6709.295523969913;6712.899306510309;5600.8518253757065;6319.146915166578;6493.188351456068;6513.641749703812;6522.543421960418 03:17:16 INFO - PID 2196 | |1;ext.html;741.2735519191192;789.0807209600815;818.3943881527671;1254.222382123084;1261.5899832554421;37339.62660373395;38256.04359891001;38520.80739596305;38584.42123368148;38612.61387386125;29387.853060734666;38490.84527464174;38496;38515.22969540607;38540;8058.838823223532;8189.140140285243;8200.794980125514;8443.493390396596;8702.782430439227;8719.997200321948;8799.34004949628;8819.603117859711;8833.160849719266;8836.116388361177;8774.780630484258;8845.778855528599;8852.468851868876;8854.557272136399;8877.866831997526;8775.990761062463;8803.471791692518;8812.691555795549;8815.426997245158;8816.647334106628;8484.236418722345;8546.829063418696;8566.785830354229;8571.699990500365;8600.83888675027;37172.628273717186;37395.62604373976;37464.25071498582;37471.62528374736;37488.81255593732;3618.6924111450558;3624.855005799765;3651.981740091309;3660.762050466711;3673.412254039341;30517;30689.539656905163;30836.53745193824;30845.69154308473;30964.8451757742;2735.5076086304657;2951.3359494113865;3194.7763656544053;3211.6627754085953;3222.8066316021113;194835;222275;251382;282288;283804;38437.23125537473;38484.80757596194;46527.81249687544;46685.533144668116;46733.29900051502;48800.53598392054;49269.75365123151;49379;49402.75298623484;49425.75287123541;14076;14171;14193.78709319361;14207.64480887986;14246.572602821932;11437.828432573351;11531.308121512737;11617.88382116168;11665;11701;11765.705857353463;12672.87327126717;13144.211347319191;13354.198748075147;13381.330933453288;5700.629459085146;5750.6262092963825;5753.85615359611;5756.798512052058;5776.295992682169;989.2284018465608;1011.1556850030307;1013.1995723378595;1030.5517100061497;1033.4161198922584;20323.695144572845;23004.212165372395;23834.284971450885;23918;24155.879220603783;975.5171190260867;1104.8397982292522;1107.7729065541544;1139.4132022008673;1139.5612689114585;11977.58078467267;12178.512859485698;12222.694432639077;12339.13626046168;12351.75296494083;301480;314312;333350;333359;333970;53653.463465365625;54062.72968635132;54100.45899540954;54199.72900135474;54667.72666136644;1317.953871614489;1328.3225554967037;1468.3319089814108;1517.787509748636;1538.96152596186;18459.630807384045;22177.334679959626;22847.771522285228;23705.762942370355;23798.286051418487;37499.625003749614;48969.75515122402;50683.23975140449;50736.23895641494;50808.72978175427;240820.7958960194;253441;298706;299127;299396;22649.320520384415;29388.7061129386;32928.83535582307;33155.00534983954;33948;43491;43970.78014609907;44200.55799442093;44430.77784611056;44486.555134448245;23751.574905505724;29880.276937688846;30015.549766753953;30316.54525182168;30757;28815.855920720263;29765.85117074401;29876.253093672833;30393.936212232467;30782.384352313275;36464;36492;36564.81717591395;36599.63400365962;36602.8169859149;28345.29136771515;29274;29949.401011979204;30510.847445763517;30799.538006929466;21960.34118976433;24045.51908961846;24172;24457;24497.632535512337 03:17:16 INFO - PID 2196 | |2;jquery.html;380.6574083325009;427.6215549238923;437.63894786800887;438.99341509877337;456.6255670350312;20233.696494552594;22009.779902200993;22600.982955766987;22803;22901.77098229017;22533.54932901341;23023.654645180337;23506.70713110778;23934.92292846822;24065.63901541478;5695.0318445864095;5945.405459454041;5995.340512543638;6289.150964619764;6431.1317972073875;6077.209962704842;6447.935520644804;6455.386738259858;6457.192850893638;6460.903086453707;6096.298925623543;6363.522735794811;6401.263854656704;6401.775937842176;6424.582402143869;6355.173827402455;6374.139491168702;6396.392342727433;6413.390727880844;6417.262014868304;5586.301712285965;5667.8583035424035;5692.316921969349;5730.140478928152;5740.7703691852275;27564;27997.86001070002;28062.85968570144;28269.434611307865;28806.42387152266;2238.854474459155;2282.657601359793;2295.4605667668084;2295.563842869866;2296.357020034393;17951.936961300566;18385.448436546925;18675.34636287737;18724.719129213074;18767.343142990067;1812.936547220841;2151.612709712251;2155.461134716321;2173.261091228974;2214.8892555372167;143713;144238.27880860632;145982;147419;154185.2290738539;11957.342346171044;12549.93725031369;12559.874401256053;12748.80876786849;12790.936045319713;14164.858351416355;15692.450764223197;16081.839181608268;16506.58733531671;16521;7719.961400192963;7810.765677029698;8399.034111077182;8616.439931404439;9266.351355405191;7405.370543503863;8636;8713.433626814236;8813.294936405073;9003.099690030944;6493.610383377012;6556.041740132401;7840.960795196102;7890.64492097857;7957.6021198939825;1818.7908390534992;1992.0836415248857;2008.4075197816678;2177.880216588071;2308.9422764431024;876.5222953490363;899.4558292233236;936.35859436285;967.5645959318194;988.2884323287221;17567.560810979572;20073.799262007484;21025.89487052555;21118.31053515715;21250.36248912535;941.990580094204;999.5601935148657;1004.6684594083935;1010.9595616175418;1018.8013337399136;10645.893541064645;10713.250072494851;10876.401797901191;10878.945605272082;10941.343519388862;683728;735539;742896;748570;752154.2176368453;148671;150524.49475505325;153197.2340138292;167343;170942.29057709512;1178.6110583507423;1219.804831227017;1228.3489750432107;1229.8032314829584;1237.4802582915197;17748.91125544364;18086.118207124047;18430.447086587425;18431.170597322885;18497.260109595467;54404;57840.421595785185;62913;64102.67948660227;64273.67863160654;96242;97698.511507442;98909;99376.01247975144;100057;7435.144958329645;8855.3801233913;9138.588763505792;9184.448933064037;9193.678221262224;14452.494162704255;14522.346494407988;14708.970372073853;14935.925320373328;14992.925035374754;11751.294922304689;12099.213551119148;12181.39093045362;12327;12441.564545240873;9811.920688724093;11213.383263920563;11443.656690299304;11531.962123408934;11701.824472632747;11771.646850594496;12051.57819476314;12166.330851803235;12605.30670813114;12706.428210730355;8867.68963086289;9047.321450891079;9059.139381758723;9076.09239076087;9263.305252105984;10278.897211028094;12055.819162712742;12082.214656047328;12298.938505307417;12369.814452783035 03:17:16 INFO - PID 2196 | |3;mootools.html;1224.4979558381065;1342.328835582209;1404.8033275341454;1410.5909286306971;1413.4487549855558;11621.302721836695;11863.822042669357;12012.09909256807;12077.214981026227;12393.25640461573;11925.761484770299;12048.216865903732;12083.939580302087;12089.03287736979;12091.516339346415;2500.3624075860675;2539.0605475973916;2548.7578680025463;2561.3212498687863;2561.692596888376;2072.699458578505;2394.4851856850773;2417.8549287042747;2418.9758102419014;2494.4138127540014;2389.199618127929;2403;2410.843295185807;2546.3379521324405;2551.3876669599254;2471.4439251168615;2474.8638824864624;2482.640017197505;2492.9002839886384;2552.9361765955814;2415.178839194682;2429.149797570854;2433.634954756783;2438.475727718549;2536;10843.457827108614;12082.275063496218;12141.332226727527;12141.635750927486;12158.574449894211;5497.285352904137;6773;6859.828504287433;6868.969654551807;6877.65611719412;4076.2051399977017;4206.158768246332;4301.225779359714;4315.719478233937;4490.371348011281;1252.3487786351138;1254.4982007197193;1283.8331016967827;1288.793792993126;1301.934903254843;15163.924180379137;15783.684326313409;16869.325226990906;16946;16973.830261697472;4938.604911607063;5787.2476578045425;5885.793997210163;5996.580239383201;6026.276846778414;12512.562060327844;12548.372581371077;12583.622491325275;12616.801403866619;12639.684007899876;6519.054737063099;6524.054012168209;6664.933350666528;6712.295209002984;6737.225219099866;5983.222181116427;6163.106349579286;6277.52918531112;6279.434850863444;6284.151639528696;4469.7318160910445;4496.415465989466;4507.166174257773;4546.340780586863;4599.218132917412;1276.50216415598;1283.6341642631805;1291.5544137272814;1310.3906683392267;1311.4885194774047;768.7539987204041;794.5431376958272;813.2477458351002;823.7899335669366;839.4501601451059;5883.528718056367;6154.661493617894;6272.341404152589;6287.685615719196;6384.138141350858;787.5904529644667;881.678187461572;895.9283257339397;913.4884464699657;917.4449458077767;4027.7986100694848;4094.651954583834;4240.830366785356;4281.608477244908;4379.802908869108;12585.433655485525;15068.698626027419;15625.531234062997;15625.765613515807;15654.686906261812;14824.629384265263;15305.846941530443;15437.15095669749;15444.305006274744;15491.612709682122;10715.517801698943;11015.449227538751;11022.952819482136;11031.558737650405;11047.944760276147;6710.463162946855;6801.285864984304;7154.354498465278;7192.2088570258275;7198.136223653195;9745.22038236925;13356.131851429625;13649;13723.147375104234;13977.371018304404;14007.859921400655;14015.789763153765;14265.358058887583;14273.072250303698;14380.928095359457;9555.283353748358;10631.043206111488;10855.402952837354;10982.121430285399;10996.505157268102;11140;11206.439678015904;11240.83138752903;11253.1560132992;11288.322700637988;9044.864327034968;9190.172884440433;9196.08039196075;9280.814383712423;9436.95281523588;9042.773930651787;9074.45553266806;9075.954620226856;9232.861507077534;9265.629374824932;6399.64801935898;7481.877718342293;8168.224018718212;8254.958725206336;8311.625976830936;6024.156618073561;6064.363241859718;6147.108669242845;6209.96895015522;6323.652199129092;5362.785488580413;5918.881622367615;6156.415140561639;6217.719705036501;6432.292447830641 03:17:16 INFO - PID 2196 | |4;prototype.html;356.7520573201625;394.2174783055636;403.1956247286662;414.8133339997002;418.4392913495916;5690.861827634474;6182.567220294582;6307.40079692429;6321.905171422427;6341.746330146801;5954.761809527614;6098.268207815057;6140.53945954053;6157.81526554203;6202.751889924398;3343.3981883261063;3627.093226693327;4263.189993901149;4549.61328287096;4562.520935301795;4524.502304746476;4542.931856022163;4545.272756358983;4574;4577.839775607855;3706.629337066285;4475.7762111894435;4531.184386810372;4533.3906463205585;4535.863924082283;3737.5328083989502;4103.692223083281;4336.284513055342;4452.265376212921;4541.409616749835;3867.5165604299464;3867.613238676138;3887.445021991198;3889.4165875118674;3890.5525864525657;4863.732494712789;4880.707157570557;6003.039513677834;6004.0693692477735;6015.4586087252355;4289.206496798102;5020;5091.643584949055;5421.132618780976;5465.726713664301;6550.901736473957;6556.541042127053;6562.685843648975;6590.462671871316;6595.604263744142;4409.382686423904;4418.403515525427;4418.447694038246;4425.668074894364;4428.383639971419;5340.279062326575;6033.758649654009;6731.519637327042;6899.586024838576;6967.616781077089;4311.719738217006;4498.5501449854755;4502.729836209838;4508.481524624644;4509.9930530913425;4334.9783251083545;4572.268437050123;4585.839495617637;4593.219152744042;4604.240300350405;4917.704937703749;5276.657017293864;5304.257403963448;5408.945910540844;5421.26812880264;4981.750912454363;6476.733143399772;6586.5389422739945;6597.8783606786965;6602.3067577904585;1254.8870601645895;1279.0023781450484;1562.6249700072128;1567.130242715304;1569.9843001569839;963.9589243616877;1025.103034844511;1031.6028329093353;1037.7716902281486;1043.2644985285356;5301.9396120776;5612.298462692163;6368.777602366108;6416;6419.390157934989;6820.31796820324;6874.312568743186;6886.655667216619;6922.826929326807;6957.79126626202;5616.859578510488;6096.72564734588;6300.21247344082;6336.746530138743;6369.745210191633;3568.1436455251073;3624.3294990426857;3638.945415818765;3646.705419576065;3674.356987527172;6169.951108311598;6493.31820158886;7057.89413158803;7088.468364872655;7089;5649.293838270216;7032.964835175791;7086.326798954091;7117.82205444868;7153.856922861513;6178.41305076017;6778.322167783281;6948.583085014915;7137.857242855114;7170.96414517924;5809.390014048464;5967.791127310524;6002.549808764273;6712.496562757715;7013.544119632207;5770.971145144247;5978.581499295007;6677.666116694243;6875.243723190545;6906.854393476892;5885.499732522612;6870.038194652652;6914.896276555755;7147.428205743424;7223.494355395072;4152.570746113557;4494.101179763995;4518.073794871978;4523.2988886722615;4547.295169248771;6694.263631000684;6896.103636472593;6990.335918087773;6993.755218567326;7007.579545227302;5582.358028826737;6483.865323568451;6608.471322294301;6708.027336036345;6723.630200339028;6353.777617783356;6581.3747693969;6645.700943457653;6670.566413183127;6693.364130407604;6438.420542151229;6507.167474152026;6514.804555863332;6522.206393241897;6553.279139294578;5317.803494213771;6217.84969780592;6714;6725.621247644319;6741.561798483083;5250.947490525199;6148.508119350352;6471.708773105127;6476.384743449365;6547.9672601636685 03:17:16 INFO - PID 2196 | |5;yui.html;758.2834221660526;848.8811566380708;861.2894362151225;868.5657171414293;877.41651801552;14286.71426571468;14922.776158357634;16410.179491025447;16858.409955651554;16868.240929158186;11981.262716906043;12473.937630311835;13522.932385338085;17287.48137555872;17317.960922344668;939.8919124300708;993.7018894331671;999.4403134244847;1000.6397696829172;1003.0871906565027;993.5677980078689;994.7264502261863;1000.6547741029369;1002.053059858434;1009.9596016159381;1027.9743006424824;1029.7168278723373;1049.1659130990843;1055.1927775251938;1059.1897198643044;785.3834739729314;1009.369144284822;1020.4795554267303;1028.1055481730866;1029.0070082370548;711.2354219214313;717.178830239373;747.6486051555814;765.6516285090327;772.142921357293;16604.169791510376;16741.74887376678;16811.663766724596;16826.915865420717;16884.493465196065;17056.65886682272;17146.228419721017;17519.912400438043;17584.736228956575;17722.379716709984;12736.917362024238;13075.934620326838;14175.149491030572;14229.501967431193;14331.498397556139;3525.5593050868642;3527.1182204448887;3553.893383198508;3554.48459973305;3559.2169722660974;116828;117649;118194;119469;120363.3981830094;13086.607401777961;13350.332483375792;13355.399007044707;13517.459301628021;13521.661958451117;25024.49951001006;25043.37391565189;25805.483890322088;25976;26145;8723.432976856484;8808.47149171039;8818.382713210141;8828.42615230008;8829.205371516466;4676.929846052312;4752.073345697556;4796.952030479651;4805.471398146201;4817.181079216542;4309.978450107729;4431.224535706238;4432.3351497275025;4433.002574420794;4437.689361744647;838.7525679924437;859.8968123825181;860.9741707748777;860.9827803443897;861.0614430271035;551.6827824001215;674.780696273713;678.7285085965653;685.9005444210561;699.1959246866043;10643.84034239487;11090.445477726082;11873.584424545099;13058.673533161556;13222;676.4182802789597;676.8307923019245;679.188369897977;682.4097155960059;701.5755467941924;5424.213489044067;5456.48163424474;5527.336719593674;5636.520895723909;5748.936446757363;101236.49381753044;104923.95076049143;105453.78184872672;106084;108331;74691.62654186803;79441;79453.60273198712;81871;91385.54307228421;57201.71399142977;72308.63845680738;72707;74254;74327;11924.403779811148;12531.060170487068;12597.244165350108;12605.243685378906;12612.936935315265;35991;36341.45487817738;37190.8140459296;37484;38785.4182187273;49659.25511117408;49824.25263621121;50355.24467133069;50439.74780126076;50539.49460505348;15239.542813715607;16014.119223442822;16034.35862565531;16081.437149699705;16196.919015404848;14439.566812995627;17584.472465826046;17766.200520976847;17853.553661158574;17937.641247175245;15757.527274181793;16116.919415402848;16348.754768678242;16446.83553164501;16448.013119212887;16074.276657550672;16157.353705851634;16305.347786088423;16322.59193520124;16433.67132657364;13033.674158146123;16476.67046659036;16709;16781.412650557173;16839.41062062871;11609.825852612386;11692.94153529227;11871.406429678655;12026.037916966796;12069.336186509827;13113.868861311646;13144.737105257651;13165.341732913124;13170.275634840176;13226.537071202461 03:17:17 INFO - PID 2196 | __end_tp_report 03:17:17 INFO - PID 2196 | __start_cc_report 03:17:17 INFO - PID 2196 | _x_x_mozilla_cycle_collect,432 03:17:17 INFO - PID 2196 | __end_cc_report 03:17:17 INFO - PID 2196 | __startTimestamp1491819436984__endTimestamp 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | ------- Summary: start ------- 03:17:17 INFO - PID 2196 | Number of tests: 6 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | [#0] dojo.html Cycles:165 Average:6236.38 Median:6440.42 stddev:754.73 (11.7%) stddev-sans-first:719.11 03:17:17 INFO - PID 2196 | Values: 3224.4 3289.4 3483.0 3504.5 3625.9 6218.8 6239.2 6278.0 6296.5 6336.5 6201.9 6258.1 6274.4 6279.6 6280.6 5466.1 5573.6 5615.9 5667.2 5668.0 4943.8 5508.3 5610.7 5671.5 5757.7 5453.6 5476.9 5498.2 5599.3 5626.0 5517.6 5522.7 5533.1 5587.7 5623.4 5456.8 5461.3 5463.3 5470.2 5503.4 6053.3 6185.6 6248.7 6267.5 6272.8 6635.5 6744.3 6773.6 6777.4 6778.5 6829.0 6864.5 6872.1 6872.7 6891.4 6273.3 6290.6 6339.3 6352.5 6358.3 6902.8 6984.8 6990.4 7010.6 7093.1 6440.4 6502.1 6540.8 6702.2 6708.3 6790.9 6844.3 6857.1 6866.2 6885.1 6507.6 6700.9 6739.4 6768.7 6793.1 6614.5 6658.6 6694.7 6754.8 6797.3 5425.0 5429.4 5440.2 5444.9 5455.3 4745.8 4757.2 4777.0 4787.2 4828.4 6118.9 6343.8 6347.1 6374.0 6406.0 6886.8 6906.5 6918.1 6922.0 6933.8 6342.7 6465.2 6472.2 6484.8 6486.5 5833.5 5917.4 5927.3 6067.6 6088.2 6807.2 6973.1 7025.1 7035.7 7057.1 6806.0 6835.5 6841.4 6864.1 6879.8 6858.5 6957.9 7017.2 7025.8 7047.3 6435.6 6512.8 6640.3 6711.2 6714.7 5876.6 6866.9 6869.5 6878.5 6901.0 6440.4 6490.5 6533.7 6560.5 6620.4 6180.7 6592.5 6629.7 6640.8 6658.0 5764.9 6265.3 6339.2 6384.8 6411.6 6581.0 6682.6 6686.0 6709.3 6712.9 5600.9 6319.1 6493.2 6513.6 6522.5 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | [#1] ext.html Cycles:180 Average:43501.85 Median:33041.92 stddev:74949.82 (226.8%) stddev-sans-first:75091.31 03:17:17 INFO - PID 2196 | Values: 741.3 789.1 818.4 1254.2 1261.6 37339.6 38256.0 38520.8 38584.4 38612.6 29387.9 38490.8 38496.0 38515.2 38540.0 8058.8 8189.1 8200.8 8443.5 8702.8 8720.0 8799.3 8819.6 8833.2 8836.1 8774.8 8845.8 8852.5 8854.6 8877.9 8776.0 8803.5 8812.7 8815.4 8816.6 8484.2 8546.8 8566.8 8571.7 8600.8 37172.6 37395.6 37464.3 37471.6 37488.8 3618.7 3624.9 3652.0 3660.8 3673.4 30517.0 30689.5 30836.5 30845.7 30964.8 2735.5 2951.3 3194.8 3211.7 3222.8 194835.0 222275.0 251382.0 282288.0 283804.0 38437.2 38484.8 46527.8 46685.5 46733.3 48800.5 49269.8 49379.0 49402.8 49425.8 14076.0 14171.0 14193.8 14207.6 14246.6 11437.8 11531.3 11617.9 11665.0 11701.0 11765.7 12672.9 13144.2 13354.2 13381.3 5700.6 5750.6 5753.9 5756.8 5776.3 989.2 1011.2 1013.2 1030.6 1033.4 20323.7 23004.2 23834.3 23918.0 24155.9 975.5 1104.8 1107.8 1139.4 1139.6 11977.6 12178.5 12222.7 12339.1 12351.8 301480.0 314312.0 333350.0 333359.0 333970.0 53653.5 54062.7 54100.5 54199.7 54667.7 1318.0 1328.3 1468.3 1517.8 1539.0 18459.6 22177.3 22847.8 23705.8 23798.3 37499.6 48969.8 50683.2 50736.2 50808.7 240820.8 253441.0 298706.0 299127.0 299396.0 22649.3 29388.7 32928.8 33155.0 33948.0 43491.0 43970.8 44200.6 44430.8 44486.6 23751.6 29880.3 30015.5 30316.5 30757.0 28815.9 29765.9 29876.3 30393.9 30782.4 36464.0 36492.0 36564.8 36599.6 36602.8 28345.3 29274.0 29949.4 30510.8 30799.5 21960.3 24045.5 24172.0 24457.0 24497.6 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | [#2] jquery.html Cycles:180 Average:41993.12 Median:2295.51 stddev:122672.94 (5344.0%) stddev-sans-first:122977.27 03:17:17 INFO - PID 2196 | Values: 380.7 427.6 437.6 439.0 456.6 20233.7 22009.8 22601.0 22803.0 22901.8 22533.5 23023.7 23506.7 23934.9 24065.6 5695.0 5945.4 5995.3 6289.2 6431.1 6077.2 6447.9 6455.4 6457.2 6460.9 6096.3 6363.5 6401.3 6401.8 6424.6 6355.2 6374.1 6396.4 6413.4 6417.3 5586.3 5667.9 5692.3 5730.1 5740.8 27564.0 27997.9 28062.9 28269.4 28806.4 2238.9 2282.7 2295.5 2295.6 2296.4 17951.9 18385.4 18675.3 18724.7 18767.3 1812.9 2151.6 2155.5 2173.3 2214.9 143713.0 144238.3 145982.0 147419.0 154185.2 11957.3 12549.9 12559.9 12748.8 12790.9 14164.9 15692.5 16081.8 16506.6 16521.0 7720.0 7810.8 8399.0 8616.4 9266.4 7405.4 8636.0 8713.4 8813.3 9003.1 6493.6 6556.0 7841.0 7890.6 7957.6 1818.8 1992.1 2008.4 2177.9 2308.9 876.5 899.5 936.4 967.6 988.3 17567.6 20073.8 21025.9 21118.3 21250.4 942.0 999.6 1004.7 1011.0 1018.8 10645.9 10713.3 10876.4 10878.9 10941.3 683728.0 735539.0 742896.0 748570.0 752154.2 148671.0 150524.5 153197.2 167343.0 170942.3 1178.6 1219.8 1228.3 1229.8 1237.5 17748.9 18086.1 18430.4 18431.2 18497.3 54404.0 57840.4 62913.0 64102.7 64273.7 96242.0 97698.5 98909.0 99376.0 100057.0 7435.1 8855.4 9138.6 9184.4 9193.7 14452.5 14522.3 14709.0 14935.9 14992.9 11751.3 12099.2 12181.4 12327.0 12441.6 9811.9 11213.4 11443.7 11532.0 11701.8 11771.6 12051.6 12166.3 12605.3 12706.4 8867.7 9047.3 9059.1 9076.1 9263.3 10278.9 12055.8 12082.2 12298.9 12369.8 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | [#3] mootools.html Cycles:180 Average:7290.66 Median:2537.53 stddev:4646.37 (183.1%) stddev-sans-first:4637.04 03:17:17 INFO - PID 2196 | Values: 1224.5 1342.3 1404.8 1410.6 1413.4 11621.3 11863.8 12012.1 12077.2 12393.3 11925.8 12048.2 12083.9 12089.0 12091.5 2500.4 2539.1 2548.8 2561.3 2561.7 2072.7 2394.5 2417.9 2419.0 2494.4 2389.2 2403.0 2410.8 2546.3 2551.4 2471.4 2474.9 2482.6 2492.9 2552.9 2415.2 2429.1 2433.6 2438.5 2536.0 10843.5 12082.3 12141.3 12141.6 12158.6 5497.3 6773.0 6859.8 6869.0 6877.7 4076.2 4206.2 4301.2 4315.7 4490.4 1252.3 1254.5 1283.8 1288.8 1301.9 15163.9 15783.7 16869.3 16946.0 16973.8 4938.6 5787.2 5885.8 5996.6 6026.3 12512.6 12548.4 12583.6 12616.8 12639.7 6519.1 6524.1 6664.9 6712.3 6737.2 5983.2 6163.1 6277.5 6279.4 6284.2 4469.7 4496.4 4507.2 4546.3 4599.2 1276.5 1283.6 1291.6 1310.4 1311.5 768.8 794.5 813.2 823.8 839.5 5883.5 6154.7 6272.3 6287.7 6384.1 787.6 881.7 895.9 913.5 917.4 4027.8 4094.7 4240.8 4281.6 4379.8 12585.4 15068.7 15625.5 15625.8 15654.7 14824.6 15305.8 15437.2 15444.3 15491.6 10715.5 11015.4 11023.0 11031.6 11047.9 6710.5 6801.3 7154.4 7192.2 7198.1 9745.2 13356.1 13649.0 13723.1 13977.4 14007.9 14015.8 14265.4 14273.1 14380.9 9555.3 10631.0 10855.4 10982.1 10996.5 11140.0 11206.4 11240.8 11253.2 11288.3 9044.9 9190.2 9196.1 9280.8 9437.0 9042.8 9074.5 9076.0 9232.9 9265.6 6399.6 7481.9 8168.2 8255.0 8311.6 6024.2 6064.4 6147.1 6210.0 6323.7 5362.8 5918.9 6156.4 6217.7 6432.3 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | [#4] prototype.html Cycles:180 Average:5300.82 Median:5973.19 stddev:1691.26 (28.3%) stddev-sans-first:1654.79 03:17:17 INFO - PID 2196 | Values: 356.8 394.2 403.2 414.8 418.4 5690.9 6182.6 6307.4 6321.9 6341.7 5954.8 6098.3 6140.5 6157.8 6202.8 3343.4 3627.1 4263.2 4549.6 4562.5 4524.5 4542.9 4545.3 4574.0 4577.8 3706.6 4475.8 4531.2 4533.4 4535.9 3737.5 4103.7 4336.3 4452.3 4541.4 3867.5 3867.6 3887.4 3889.4 3890.6 4863.7 4880.7 6003.0 6004.1 6015.5 4289.2 5020.0 5091.6 5421.1 5465.7 6550.9 6556.5 6562.7 6590.5 6595.6 4409.4 4418.4 4418.4 4425.7 4428.4 5340.3 6033.8 6731.5 6899.6 6967.6 4311.7 4498.6 4502.7 4508.5 4510.0 4335.0 4572.3 4585.8 4593.2 4604.2 4917.7 5276.7 5304.3 5408.9 5421.3 4981.8 6476.7 6586.5 6597.9 6602.3 1254.9 1279.0 1562.6 1567.1 1570.0 964.0 1025.1 1031.6 1037.8 1043.3 5301.9 5612.3 6368.8 6416.0 6419.4 6820.3 6874.3 6886.7 6922.8 6957.8 5616.9 6096.7 6300.2 6336.7 6369.7 3568.1 3624.3 3638.9 3646.7 3674.4 6170.0 6493.3 7057.9 7088.5 7089.0 5649.3 7033.0 7086.3 7117.8 7153.9 6178.4 6778.3 6948.6 7137.9 7171.0 5809.4 5967.8 6002.5 6712.5 7013.5 5771.0 5978.6 6677.7 6875.2 6906.9 5885.5 6870.0 6914.9 7147.4 7223.5 4152.6 4494.1 4518.1 4523.3 4547.3 6694.3 6896.1 6990.3 6993.8 7007.6 5582.4 6483.9 6608.5 6708.0 6723.6 6353.8 6581.4 6645.7 6670.6 6693.4 6438.4 6507.2 6514.8 6522.2 6553.3 5317.8 6217.8 6714.0 6725.6 6741.6 5250.9 6148.5 6471.7 6476.4 6548.0 03:17:17 INFO - PID 2196 | 03:17:17 INFO - PID 2196 | [#5] yui.html Cycles:180 Average:20711.11 Median:17302.72 stddev:28648.62 (165.6%) stddev-sans-first:28689.81 03:17:17 INFO - PID 2196 | Values: 758.3 848.9 861.3 868.6 877.4 14286.7 14922.8 16410.2 16858.4 16868.2 11981.3 12473.9 13522.9 17287.5 17318.0 939.9 993.7 999.4 1000.6 1003.1 993.6 994.7 1000.7 1002.1 1010.0 1028.0 1029.7 1049.2 1055.2 1059.2 785.4 1009.4 1020.5 1028.1 1029.0 711.2 717.2 747.6 765.7 772.1 16604.2 16741.7 16811.7 16826.9 16884.5 17056.7 17146.2 17519.9 17584.7 17722.4 12736.9 13075.9 14175.1 14229.5 14331.5 3525.6 3527.1 3553.9 3554.5 3559.2 116828.0 117649.0 118194.0 119469.0 120363.4 13086.6 13350.3 13355.4 13517.5 13521.7 25024.5 25043.4 25805.5 25976.0 26145.0 8723.4 8808.5 8818.4 8828.4 8829.2 4676.9 4752.1 4797.0 4805.5 4817.2 4310.0 4431.2 4432.3 4433.0 4437.7 838.8 859.9 861.0 861.0 861.1 551.7 674.8 678.7 685.9 699.2 10643.8 11090.4 11873.6 13058.7 13222.0 676.4 676.8 679.2 682.4 701.6 5424.2 5456.5 5527.3 5636.5 5748.9 101236.5 104924.0 105453.8 106084.0 108331.0 74691.6 79441.0 79453.6 81871.0 91385.5 57201.7 72308.6 72707.0 74254.0 74327.0 11924.4 12531.1 12597.2 12605.2 12612.9 35991.0 36341.5 37190.8 37484.0 38785.4 49659.3 49824.3 50355.2 50439.7 50539.5 15239.5 16014.1 16034.4 16081.4 16196.9 14439.6 17584.5 17766.2 17853.6 17937.6 15757.5 16116.9 16348.8 16446.8 16448.0 16074.3 16157.4 16305.3 16322.6 16433.7 13033.7 16476.7 16709.0 16781.4 16839.4 11609.8 11692.9 11871.4 12026.0 12069.3 13113.9 13144.7 13165.3 13170.3 13226.5 03:17:17 INFO - PID 2196 | -------- Summary: end -------- 03:17:17 INFO - PID 2196 | 03:17:17 INFO - TEST-INFO | 2196: exit 0 03:17:17 INFO - TEST-OK | dromaeo_css | took 1115865ms 03:17:17 INFO - TEST-START | kraken 03:17:17 INFO - operating with platform_type : mac_ 03:17:17 INFO - Initialising browser for kraken test... 03:17:17 INFO - TEST-INFO | started process 2202 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmp7Sx4_s/profile http://localhost:56568/getInfo.html) 03:17:20 INFO - PID 2202 | 2017-04-10 03:17:20.697 plugin-container[2203:27871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 03:17:20 INFO - PID 2202 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:20 INFO - PID 2202 | 2017-04-10 03:17:20.701 plugin-container[2203:27871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 03:17:20 INFO - PID 2202 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:20 INFO - PID 2202 | 2017-04-10 03:17:20.701 plugin-container[2203:27871] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:20 INFO - PID 2202 | __metrics Screen width/height:1600/1200 03:17:20 INFO - PID 2202 | colorDepth:24 03:17:20 INFO - PID 2202 | Browser inner width/height: 1024/689 03:17:20 INFO - PID 2202 | __metrics 03:17:20 ERROR - PID 2202 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 03:17:21 INFO - TEST-INFO | 2202: exit 0 03:17:21 INFO - Browser initialized. 03:17:21 INFO - Running cycle 1/1 for kraken test... 03:17:21 INFO - TEST-INFO | started process 2204 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmp7Sx4_s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:24 INFO - PID 2204 | 2017-04-10 03:17:24.546 plugin-container[2205:27993] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 03:17:24 INFO - PID 2204 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:24 INFO - PID 2204 | 2017-04-10 03:17:24.547 plugin-container[2205:27993] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e17, name = 'com.apple.CFPasteboardClient' 03:17:24 INFO - PID 2204 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:24 INFO - PID 2204 | 2017-04-10 03:17:24.547 plugin-container[2205:27993] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:34 INFO - PID 2204 | RSS: Main: 234242048 03:17:34 INFO - PID 2204 | 03:17:37 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56568/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:38 INFO - PID 2204 | RSS: Main: 249126912 03:17:38 INFO - PID 2204 | 03:17:41 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56568/tests/kraken/driver.html?testName=audio-dft) 03:17:41 INFO - PID 2204 | RSS: Main: 257691648 03:17:41 INFO - PID 2204 | 03:17:45 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56568/tests/kraken/driver.html?testName=audio-fft) 03:17:46 INFO - PID 2204 | RSS: Main: 260165632 03:17:46 INFO - PID 2204 | 03:17:48 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56568/tests/kraken/driver.html?testName=audio-oscillator) 03:17:48 INFO - PID 2204 | RSS: Main: 261980160 03:17:48 INFO - PID 2204 | 03:17:50 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:51 INFO - PID 2204 | RSS: Main: 262377472 03:17:51 INFO - PID 2204 | 03:17:54 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56568/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:55 INFO - PID 2204 | RSS: Main: 268259328 03:17:55 INFO - PID 2204 | 03:17:58 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56568/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:59 INFO - PID 2204 | RSS: Main: 268996608 03:17:59 INFO - PID 2204 | 03:18:02 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56568/tests/kraken/driver.html?testName=json-parse-financial) 03:18:03 INFO - PID 2204 | RSS: Main: 268865536 03:18:03 INFO - PID 2204 | 03:18:04 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:18:05 INFO - PID 2204 | RSS: Main: 268742656 03:18:05 INFO - PID 2204 | 03:18:07 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:18:07 INFO - PID 2204 | RSS: Main: 268627968 03:18:07 INFO - PID 2204 | 03:18:09 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:10 INFO - PID 2204 | RSS: Main: 268730368 03:18:10 INFO - PID 2204 | 03:18:13 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:14 INFO - PID 2204 | RSS: Main: 269070336 03:18:14 INFO - PID 2204 | 03:18:17 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:18 INFO - PID 2204 | RSS: Main: 266678272 03:18:18 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | Cycle 1(1): loaded http://localhost:56568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56568/tests/kraken/driver.html?testName=ai-astar) 03:18:20 INFO - PID 2204 | RSS: Main: 269987840 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | __start_tp_report 03:18:20 INFO - PID 2204 | _x_x_mozilla_page_load 03:18:20 INFO - PID 2204 | _x_x_mozilla_page_load_details 03:18:20 INFO - PID 2204 | |i|pagename|runs| 03:18:20 INFO - PID 2204 | |0;ai-astar;108;120;120;118;123;136;108;137;180;159 03:18:20 INFO - PID 2204 | |1;audio-beat-detection;165;159;160;176;120;136;155;117;148;128 03:18:20 INFO - PID 2204 | |2;audio-dft;255;310;295;213;212;217;207;219;217;215 03:18:20 INFO - PID 2204 | |3;audio-fft;85;61;61;91;60;64;61;61;76;64 03:18:20 INFO - PID 2204 | |4;audio-oscillator;99;71;90;73;73;74;87;73;73;87 03:18:20 INFO - PID 2204 | |5;imaging-gaussian-blur;92;142;124;92;91;92;93;101;101;140 03:18:20 INFO - PID 2204 | |6;imaging-darkroom;101;104;101;112;101;101;114;96;166;167 03:18:20 INFO - PID 2204 | |7;imaging-desaturate;105;101;102;103;105;100;166;150;104;101 03:18:20 INFO - PID 2204 | |8;json-parse-financial;53;53;52;55;54;54;53;55;54;53 03:18:20 INFO - PID 2204 | |9;json-stringify-tinderbox;60;67;61;68;61;77;66;61;62;63 03:18:20 INFO - PID 2204 | |10;stanford-crypto-aes;87;88;93;102;88;88;89;89;87;88 03:18:20 INFO - PID 2204 | |11;stanford-crypto-ccm;149;148;158;149;162;176;171;172;227;172 03:18:20 INFO - PID 2204 | |12;stanford-crypto-pbkdf2;201;197;210;237;199;194;199;221;218;251 03:18:20 INFO - PID 2204 | |13;stanford-crypto-sha256-iterative;72;79;103;106;94;97;107;101;78;59 03:18:20 INFO - PID 2204 | __end_tp_report 03:18:20 INFO - PID 2204 | __start_cc_report 03:18:20 INFO - PID 2204 | _x_x_mozilla_cycle_collect,997 03:18:20 INFO - PID 2204 | __end_cc_report 03:18:20 INFO - PID 2204 | __startTimestamp1491819500679__endTimestamp 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | ------- Summary: start ------- 03:18:20 INFO - PID 2204 | Number of tests: 14 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#0] ai-astar Cycles:10 Average:130.90 Median:129.50 stddev:23.04 (17.8%) stddev-sans-first:22.90 03:18:20 INFO - PID 2204 | Values: 108.0 120.0 120.0 118.0 123.0 136.0 108.0 137.0 180.0 159.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:157.00 stddev:20.14 (12.8%) stddev-sans-first:20.21 03:18:20 INFO - PID 2204 | Values: 165.0 159.0 160.0 176.0 120.0 136.0 155.0 117.0 148.0 128.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#2] audio-dft Cycles:10 Average:236.00 Median:218.00 stddev:37.59 (17.2%) stddev-sans-first:39.23 03:18:20 INFO - PID 2204 | Values: 255.0 310.0 295.0 213.0 212.0 217.0 207.0 219.0 217.0 215.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#3] audio-fft Cycles:10 Average:68.40 Median:64.00 stddev:11.41 (17.8%) stddev-sans-first:10.41 03:18:20 INFO - PID 2204 | Values: 85.0 61.0 61.0 91.0 60.0 64.0 61.0 61.0 76.0 64.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#4] audio-oscillator Cycles:10 Average:80.00 Median:80.50 stddev:9.84 (12.2%) stddev-sans-first:7.67 03:18:20 INFO - PID 2204 | Values: 99.0 71.0 90.0 73.0 73.0 74.0 87.0 73.0 73.0 87.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#5] imaging-gaussian-blur Cycles:10 Average:106.80 Median:91.50 stddev:20.55 (22.5%) stddev-sans-first:21.09 03:18:20 INFO - PID 2204 | Values: 92.0 142.0 124.0 92.0 91.0 92.0 93.0 101.0 101.0 140.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#6] imaging-darkroom Cycles:10 Average:116.30 Median:113.00 stddev:27.01 (23.9%) stddev-sans-first:28.07 03:18:20 INFO - PID 2204 | Values: 101.0 104.0 101.0 112.0 101.0 101.0 114.0 96.0 166.0 167.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#7] imaging-desaturate Cycles:10 Average:113.70 Median:104.50 stddev:23.71 (22.7%) stddev-sans-first:24.94 03:18:20 INFO - PID 2204 | Values: 105.0 101.0 102.0 103.0 105.0 100.0 166.0 150.0 104.0 101.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 03:18:20 INFO - PID 2204 | Values: 53.0 53.0 52.0 55.0 54.0 54.0 53.0 55.0 54.0 53.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:5.19 (8.0%) stddev-sans-first:5.23 03:18:20 INFO - PID 2204 | Values: 60.0 67.0 61.0 68.0 61.0 77.0 66.0 61.0 62.0 63.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:4.58 (5.2%) stddev-sans-first:4.74 03:18:20 INFO - PID 2204 | Values: 87.0 88.0 93.0 102.0 88.0 88.0 89.0 89.0 87.0 88.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#11] stanford-crypto-ccm Cycles:10 Average:168.40 Median:171.50 stddev:23.20 (13.5%) stddev-sans-first:23.52 03:18:20 INFO - PID 2204 | Values: 149.0 148.0 158.0 149.0 162.0 176.0 171.0 172.0 227.0 172.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:212.70 Median:214.00 stddev:19.06 (8.9%) stddev-sans-first:19.74 03:18:20 INFO - PID 2204 | Values: 201.0 197.0 210.0 237.0 199.0 194.0 199.0 221.0 218.0 251.0 03:18:20 INFO - PID 2204 | 03:18:20 INFO - PID 2204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.60 Median:75.00 stddev:16.49 (22.0%) stddev-sans-first:16.22 03:18:20 INFO - PID 2204 | Values: 72.0 79.0 103.0 106.0 94.0 97.0 107.0 101.0 78.0 59.0 03:18:20 INFO - PID 2204 | -------- Summary: end -------- 03:18:20 INFO - PID 2204 | 03:18:21 INFO - TEST-INFO | 2204: exit 0 03:18:21 INFO - TEST-OK | kraken | took 64123ms 03:18:21 INFO - SUITE-END | took 1179s 03:18:22 INFO - Completed test suite (00:19:40) 03:18:22 INFO - javascript benchmark 03:18:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7919.331938340503, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.3873664003854, 3289.3914625794237, 3483.02475306914, 3504.474328850672, 3625.909352266193, 6218.751249950008, 6239.220097487814, 6277.968610156949, 6296.527760417964, 6336.493080553556, 6201.906971395432, 6258.061290806381, 6274.4353008229255, 6279.623222606635, 6280.591761535497, 5466.098093814516, 5573.6098473106695, 5615.943840561604, 5667.178259152441, 5668.036433806263, 4943.788771750926, 5508.256385387981, 5610.69141197234, 5671.461211184931, 5757.712114394284, 5453.590980676465, 5476.91784623231, 5498.202760599731, 5599.272094627713, 5625.987322282008, 5517.641353312022, 5522.66863988162, 5533.142362933751, 5587.664740115606, 5623.381428042912, 5456.7544460499375, 5461.344638643349, 5463.344398672145, 5470.234167216593, 5503.449655034505, 6053.303870054956, 6185.628862268233, 6248.656323902183, 6267.5299352548745, 6272.780452684134, 6635.4691624670395, 6744.325567443266, 6773.593584384904, 6777.390034896834, 6778.457723382117, 6829.0, 6864.519483636147, 6872.10662613862, 6872.725090996354, 6891.37977582015, 6273.309935907047, 6290.559660823698, 6339.334369891188, 6352.460040896575, 6358.300586935434, 6902.758403455855, 6984.825379365557, 6990.440764738809, 7010.614416207056, 7093.077899872984, 6440.420362167428, 6502.122213501211, 6540.8364790880605, 6702.162229721285, 6708.3291670833505, 6790.898136527956, 6844.349786770249, 6857.108575885203, 6866.244713081557, 6885.070515480346, 6507.577007494498, 6700.865982680319, 6739.359760822714, 6768.661566921634, 6793.082933803873, 6614.470842332602, 6658.5671931324305, 6694.665266736643, 6754.763583274562, 6797.2523022467485, 5424.972875135599, 5429.429909859408, 5440.211169380417, 5444.945550544444, 5455.290812194468, 4745.766100813813, 4757.215059515211, 4777.0, 4787.210110331756, 4828.444728856156, 6118.862843290023, 6343.809685709436, 6347.1114044033875, 6374.043893416025, 6405.967970160119, 6886.793396198122, 6906.482013848981, 6918.135233095863, 6921.996310535045, 6933.826654333581, 6342.746290148435, 6465.1595292611655, 6472.158619379545, 6484.805455836333, 6486.481081513468, 5833.4749872511675, 5917.378675239124, 5927.2590926134235, 6067.635941843503, 6088.208532890696, 6807.217170025411, 6973.093497845248, 7025.121859767529, 7035.718571257093, 7057.082579264663, 6806.0, 6835.521513494008, 6841.350071743176, 6864.107666003388, 6879.793606191823, 6858.5199036067, 6957.930420695729, 7017.193022802239, 7025.824354391181, 7047.295270472911, 6435.581687190318, 6512.837179070561, 6640.302768209462, 6711.194656641234, 6714.731410743516, 5876.647401155944, 6866.896996544956, 6869.519133660796, 6878.518503704692, 6901.0, 6440.355964403522, 6490.480761538971, 6533.738650454119, 6560.540762146604, 6620.404163625104, 6180.702052568831, 6592.472602191909, 6629.668516574248, 6640.767573134917, 6657.966710166418, 5764.884702306014, 6265.310815810166, 6339.207599050119, 6384.840378990562, 6411.615303081643, 6581.045748366556, 6682.63245521501, 6686.030525573668, 6709.295523969913, 6712.899306510309, 5600.8518253757065, 6319.146915166578, 6493.188351456068, 6513.641749703812, 6522.543421960418], "value": 6182.891009571624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.2735519191192, 789.0807209600815, 818.3943881527671, 1254.222382123084, 1261.5899832554421, 37339.62660373395, 38256.04359891001, 38520.80739596305, 38584.42123368148, 38612.61387386125, 29387.853060734666, 38490.84527464174, 38496.0, 38515.22969540607, 38540.0, 8058.838823223532, 8189.140140285243, 8200.794980125514, 8443.493390396596, 8702.782430439227, 8719.997200321948, 8799.34004949628, 8819.603117859711, 8833.160849719266, 8836.116388361177, 8774.780630484258, 8845.778855528599, 8852.468851868876, 8854.557272136399, 8877.866831997526, 8775.990761062463, 8803.471791692518, 8812.691555795549, 8815.426997245158, 8816.647334106628, 8484.236418722345, 8546.829063418696, 8566.785830354229, 8571.699990500365, 8600.83888675027, 37172.628273717186, 37395.62604373976, 37464.25071498582, 37471.62528374736, 37488.81255593732, 3618.6924111450558, 3624.855005799765, 3651.981740091309, 3660.762050466711, 3673.412254039341, 30517.0, 30689.539656905163, 30836.53745193824, 30845.69154308473, 30964.8451757742, 2735.5076086304657, 2951.3359494113865, 3194.7763656544053, 3211.6627754085953, 3222.8066316021113, 194835.0, 222275.0, 251382.0, 282288.0, 283804.0, 38437.23125537473, 38484.80757596194, 46527.81249687544, 46685.533144668116, 46733.29900051502, 48800.53598392054, 49269.75365123151, 49379.0, 49402.75298623484, 49425.75287123541, 14076.0, 14171.0, 14193.78709319361, 14207.64480887986, 14246.572602821932, 11437.828432573351, 11531.308121512737, 11617.88382116168, 11665.0, 11701.0, 11765.705857353463, 12672.87327126717, 13144.211347319191, 13354.198748075147, 13381.330933453288, 5700.629459085146, 5750.6262092963825, 5753.85615359611, 5756.798512052058, 5776.295992682169, 989.2284018465608, 1011.1556850030307, 1013.1995723378595, 1030.5517100061497, 1033.4161198922584, 20323.695144572845, 23004.212165372395, 23834.284971450885, 23918.0, 24155.879220603783, 975.5171190260867, 1104.8397982292522, 1107.7729065541544, 1139.4132022008673, 1139.5612689114585, 11977.58078467267, 12178.512859485698, 12222.694432639077, 12339.13626046168, 12351.75296494083, 301480.0, 314312.0, 333350.0, 333359.0, 333970.0, 53653.463465365625, 54062.72968635132, 54100.45899540954, 54199.72900135474, 54667.72666136644, 1317.953871614489, 1328.3225554967037, 1468.3319089814108, 1517.787509748636, 1538.96152596186, 18459.630807384045, 22177.334679959626, 22847.771522285228, 23705.762942370355, 23798.286051418487, 37499.625003749614, 48969.75515122402, 50683.23975140449, 50736.23895641494, 50808.72978175427, 240820.7958960194, 253441.0, 298706.0, 299127.0, 299396.0, 22649.320520384415, 29388.7061129386, 32928.83535582307, 33155.00534983954, 33948.0, 43491.0, 43970.78014609907, 44200.55799442093, 44430.77784611056, 44486.555134448245, 23751.574905505724, 29880.276937688846, 30015.549766753953, 30316.54525182168, 30757.0, 28815.855920720263, 29765.85117074401, 29876.253093672833, 30393.936212232467, 30782.384352313275, 36464.0, 36492.0, 36564.81717591395, 36599.63400365962, 36602.8169859149, 28345.29136771515, 29274.0, 29949.401011979204, 30510.847445763517, 30799.538006929466, 21960.34118976433, 24045.51908961846, 24172.0, 24457.0, 24497.632535512337], "value": 17316.130110987197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6574083325009, 427.6215549238923, 437.63894786800887, 438.99341509877337, 456.6255670350312, 20233.696494552594, 22009.779902200993, 22600.982955766987, 22803.0, 22901.77098229017, 22533.54932901341, 23023.654645180337, 23506.70713110778, 23934.92292846822, 24065.63901541478, 5695.0318445864095, 5945.405459454041, 5995.340512543638, 6289.150964619764, 6431.1317972073875, 6077.209962704842, 6447.935520644804, 6455.386738259858, 6457.192850893638, 6460.903086453707, 6096.298925623543, 6363.522735794811, 6401.263854656704, 6401.775937842176, 6424.582402143869, 6355.173827402455, 6374.139491168702, 6396.392342727433, 6413.390727880844, 6417.262014868304, 5586.301712285965, 5667.8583035424035, 5692.316921969349, 5730.140478928152, 5740.7703691852275, 27564.0, 27997.86001070002, 28062.85968570144, 28269.434611307865, 28806.42387152266, 2238.854474459155, 2282.657601359793, 2295.4605667668084, 2295.563842869866, 2296.357020034393, 17951.936961300566, 18385.448436546925, 18675.34636287737, 18724.719129213074, 18767.343142990067, 1812.936547220841, 2151.612709712251, 2155.461134716321, 2173.261091228974, 2214.8892555372167, 143713.0, 144238.27880860632, 145982.0, 147419.0, 154185.2290738539, 11957.342346171044, 12549.93725031369, 12559.874401256053, 12748.80876786849, 12790.936045319713, 14164.858351416355, 15692.450764223197, 16081.839181608268, 16506.58733531671, 16521.0, 7719.961400192963, 7810.765677029698, 8399.034111077182, 8616.439931404439, 9266.351355405191, 7405.370543503863, 8636.0, 8713.433626814236, 8813.294936405073, 9003.099690030944, 6493.610383377012, 6556.041740132401, 7840.960795196102, 7890.64492097857, 7957.6021198939825, 1818.7908390534992, 1992.0836415248857, 2008.4075197816678, 2177.880216588071, 2308.9422764431024, 876.5222953490363, 899.4558292233236, 936.35859436285, 967.5645959318194, 988.2884323287221, 17567.560810979572, 20073.799262007484, 21025.89487052555, 21118.31053515715, 21250.36248912535, 941.990580094204, 999.5601935148657, 1004.6684594083935, 1010.9595616175418, 1018.8013337399136, 10645.893541064645, 10713.250072494851, 10876.401797901191, 10878.945605272082, 10941.343519388862, 683728.0, 735539.0, 742896.0, 748570.0, 752154.2176368453, 148671.0, 150524.49475505325, 153197.2340138292, 167343.0, 170942.29057709512, 1178.6110583507423, 1219.804831227017, 1228.3489750432107, 1229.8032314829584, 1237.4802582915197, 17748.91125544364, 18086.118207124047, 18430.447086587425, 18431.170597322885, 18497.260109595467, 54404.0, 57840.421595785185, 62913.0, 64102.67948660227, 64273.67863160654, 96242.0, 97698.511507442, 98909.0, 99376.01247975144, 100057.0, 7435.144958329645, 8855.3801233913, 9138.588763505792, 9184.448933064037, 9193.678221262224, 14452.494162704255, 14522.346494407988, 14708.970372073853, 14935.925320373328, 14992.925035374754, 11751.294922304689, 12099.213551119148, 12181.39093045362, 12327.0, 12441.564545240873, 9811.920688724093, 11213.383263920563, 11443.656690299304, 11531.962123408934, 11701.824472632747, 11771.646850594496, 12051.57819476314, 12166.330851803235, 12605.30670813114, 12706.428210730355, 8867.68963086289, 9047.321450891079, 9059.139381758723, 9076.09239076087, 9263.305252105984, 10278.897211028094, 12055.819162712742, 12082.214656047328, 12298.938505307417, 12369.814452783035], "value": 10693.11117837958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.4979558381065, 1342.328835582209, 1404.8033275341454, 1410.5909286306971, 1413.4487549855558, 11621.302721836695, 11863.822042669357, 12012.09909256807, 12077.214981026227, 12393.25640461573, 11925.761484770299, 12048.216865903732, 12083.939580302087, 12089.03287736979, 12091.516339346415, 2500.3624075860675, 2539.0605475973916, 2548.7578680025463, 2561.3212498687863, 2561.692596888376, 2072.699458578505, 2394.4851856850773, 2417.8549287042747, 2418.9758102419014, 2494.4138127540014, 2389.199618127929, 2403.0, 2410.843295185807, 2546.3379521324405, 2551.3876669599254, 2471.4439251168615, 2474.8638824864624, 2482.640017197505, 2492.9002839886384, 2552.9361765955814, 2415.178839194682, 2429.149797570854, 2433.634954756783, 2438.475727718549, 2536.0, 10843.457827108614, 12082.275063496218, 12141.332226727527, 12141.635750927486, 12158.574449894211, 5497.285352904137, 6773.0, 6859.828504287433, 6868.969654551807, 6877.65611719412, 4076.2051399977017, 4206.158768246332, 4301.225779359714, 4315.719478233937, 4490.371348011281, 1252.3487786351138, 1254.4982007197193, 1283.8331016967827, 1288.793792993126, 1301.934903254843, 15163.924180379137, 15783.684326313409, 16869.325226990906, 16946.0, 16973.830261697472, 4938.604911607063, 5787.2476578045425, 5885.793997210163, 5996.580239383201, 6026.276846778414, 12512.562060327844, 12548.372581371077, 12583.622491325275, 12616.801403866619, 12639.684007899876, 6519.054737063099, 6524.054012168209, 6664.933350666528, 6712.295209002984, 6737.225219099866, 5983.222181116427, 6163.106349579286, 6277.52918531112, 6279.434850863444, 6284.151639528696, 4469.7318160910445, 4496.415465989466, 4507.166174257773, 4546.340780586863, 4599.218132917412, 1276.50216415598, 1283.6341642631805, 1291.5544137272814, 1310.3906683392267, 1311.4885194774047, 768.7539987204041, 794.5431376958272, 813.2477458351002, 823.7899335669366, 839.4501601451059, 5883.528718056367, 6154.661493617894, 6272.341404152589, 6287.685615719196, 6384.138141350858, 787.5904529644667, 881.678187461572, 895.9283257339397, 913.4884464699657, 917.4449458077767, 4027.7986100694848, 4094.651954583834, 4240.830366785356, 4281.608477244908, 4379.802908869108, 12585.433655485525, 15068.698626027419, 15625.531234062997, 15625.765613515807, 15654.686906261812, 14824.629384265263, 15305.846941530443, 15437.15095669749, 15444.305006274744, 15491.612709682122, 10715.517801698943, 11015.449227538751, 11022.952819482136, 11031.558737650405, 11047.944760276147, 6710.463162946855, 6801.285864984304, 7154.354498465278, 7192.2088570258275, 7198.136223653195, 9745.22038236925, 13356.131851429625, 13649.0, 13723.147375104234, 13977.371018304404, 14007.859921400655, 14015.789763153765, 14265.358058887583, 14273.072250303698, 14380.928095359457, 9555.283353748358, 10631.043206111488, 10855.402952837354, 10982.121430285399, 10996.505157268102, 11140.0, 11206.439678015904, 11240.83138752903, 11253.1560132992, 11288.322700637988, 9044.864327034968, 9190.172884440433, 9196.08039196075, 9280.814383712423, 9436.95281523588, 9042.773930651787, 9074.45553266806, 9075.954620226856, 9232.861507077534, 9265.629374824932, 6399.64801935898, 7481.877718342293, 8168.224018718212, 8254.958725206336, 8311.625976830936, 6024.156618073561, 6064.363241859718, 6147.108669242845, 6209.96895015522, 6323.652199129092, 5362.785488580413, 5918.881622367615, 6156.415140561639, 6217.719705036501, 6432.292447830641], "value": 5468.757709355616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7520573201625, 394.2174783055636, 403.1956247286662, 414.8133339997002, 418.4392913495916, 5690.861827634474, 6182.567220294582, 6307.40079692429, 6321.905171422427, 6341.746330146801, 5954.761809527614, 6098.268207815057, 6140.53945954053, 6157.81526554203, 6202.751889924398, 3343.3981883261063, 3627.093226693327, 4263.189993901149, 4549.61328287096, 4562.520935301795, 4524.502304746476, 4542.931856022163, 4545.272756358983, 4574.0, 4577.839775607855, 3706.629337066285, 4475.7762111894435, 4531.184386810372, 4533.3906463205585, 4535.863924082283, 3737.5328083989502, 4103.692223083281, 4336.284513055342, 4452.265376212921, 4541.409616749835, 3867.5165604299464, 3867.613238676138, 3887.445021991198, 3889.4165875118674, 3890.5525864525657, 4863.732494712789, 4880.707157570557, 6003.039513677834, 6004.0693692477735, 6015.4586087252355, 4289.206496798102, 5020.0, 5091.643584949055, 5421.132618780976, 5465.726713664301, 6550.901736473957, 6556.541042127053, 6562.685843648975, 6590.462671871316, 6595.604263744142, 4409.382686423904, 4418.403515525427, 4418.447694038246, 4425.668074894364, 4428.383639971419, 5340.279062326575, 6033.758649654009, 6731.519637327042, 6899.586024838576, 6967.616781077089, 4311.719738217006, 4498.5501449854755, 4502.729836209838, 4508.481524624644, 4509.9930530913425, 4334.9783251083545, 4572.268437050123, 4585.839495617637, 4593.219152744042, 4604.240300350405, 4917.704937703749, 5276.657017293864, 5304.257403963448, 5408.945910540844, 5421.26812880264, 4981.750912454363, 6476.733143399772, 6586.5389422739945, 6597.8783606786965, 6602.3067577904585, 1254.8870601645895, 1279.0023781450484, 1562.6249700072128, 1567.130242715304, 1569.9843001569839, 963.9589243616877, 1025.103034844511, 1031.6028329093353, 1037.7716902281486, 1043.2644985285356, 5301.9396120776, 5612.298462692163, 6368.777602366108, 6416.0, 6419.390157934989, 6820.31796820324, 6874.312568743186, 6886.655667216619, 6922.826929326807, 6957.79126626202, 5616.859578510488, 6096.72564734588, 6300.21247344082, 6336.746530138743, 6369.745210191633, 3568.1436455251073, 3624.3294990426857, 3638.945415818765, 3646.705419576065, 3674.356987527172, 6169.951108311598, 6493.31820158886, 7057.89413158803, 7088.468364872655, 7089.0, 5649.293838270216, 7032.964835175791, 7086.326798954091, 7117.82205444868, 7153.856922861513, 6178.41305076017, 6778.322167783281, 6948.583085014915, 7137.857242855114, 7170.96414517924, 5809.390014048464, 5967.791127310524, 6002.549808764273, 6712.496562757715, 7013.544119632207, 5770.971145144247, 5978.581499295007, 6677.666116694243, 6875.243723190545, 6906.854393476892, 5885.499732522612, 6870.038194652652, 6914.896276555755, 7147.428205743424, 7223.494355395072, 4152.570746113557, 4494.101179763995, 4518.073794871978, 4523.2988886722615, 4547.295169248771, 6694.263631000684, 6896.103636472593, 6990.335918087773, 6993.755218567326, 7007.579545227302, 5582.358028826737, 6483.865323568451, 6608.471322294301, 6708.027336036345, 6723.630200339028, 6353.777617783356, 6581.3747693969, 6645.700943457653, 6670.566413183127, 6693.364130407604, 6438.420542151229, 6507.167474152026, 6514.804555863332, 6522.206393241897, 6553.279139294578, 5317.803494213771, 6217.84969780592, 6714.0, 6725.621247644319, 6741.561798483083, 5250.947490525199, 6148.508119350352, 6471.708773105127, 6476.384743449365, 6547.9672601636685], "value": 4773.649833626447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.2834221660526, 848.8811566380708, 861.2894362151225, 868.5657171414293, 877.41651801552, 14286.71426571468, 14922.776158357634, 16410.179491025447, 16858.409955651554, 16868.240929158186, 11981.262716906043, 12473.937630311835, 13522.932385338085, 17287.48137555872, 17317.960922344668, 939.8919124300708, 993.7018894331671, 999.4403134244847, 1000.6397696829172, 1003.0871906565027, 993.5677980078689, 994.7264502261863, 1000.6547741029369, 1002.053059858434, 1009.9596016159381, 1027.9743006424824, 1029.7168278723373, 1049.1659130990843, 1055.1927775251938, 1059.1897198643044, 785.3834739729314, 1009.369144284822, 1020.4795554267303, 1028.1055481730866, 1029.0070082370548, 711.2354219214313, 717.178830239373, 747.6486051555814, 765.6516285090327, 772.142921357293, 16604.169791510376, 16741.74887376678, 16811.663766724596, 16826.915865420717, 16884.493465196065, 17056.65886682272, 17146.228419721017, 17519.912400438043, 17584.736228956575, 17722.379716709984, 12736.917362024238, 13075.934620326838, 14175.149491030572, 14229.501967431193, 14331.498397556139, 3525.5593050868642, 3527.1182204448887, 3553.893383198508, 3554.48459973305, 3559.2169722660974, 116828.0, 117649.0, 118194.0, 119469.0, 120363.3981830094, 13086.607401777961, 13350.332483375792, 13355.399007044707, 13517.459301628021, 13521.661958451117, 25024.49951001006, 25043.37391565189, 25805.483890322088, 25976.0, 26145.0, 8723.432976856484, 8808.47149171039, 8818.382713210141, 8828.42615230008, 8829.205371516466, 4676.929846052312, 4752.073345697556, 4796.952030479651, 4805.471398146201, 4817.181079216542, 4309.978450107729, 4431.224535706238, 4432.3351497275025, 4433.002574420794, 4437.689361744647, 838.7525679924437, 859.8968123825181, 860.9741707748777, 860.9827803443897, 861.0614430271035, 551.6827824001215, 674.780696273713, 678.7285085965653, 685.9005444210561, 699.1959246866043, 10643.84034239487, 11090.445477726082, 11873.584424545099, 13058.673533161556, 13222.0, 676.4182802789597, 676.8307923019245, 679.188369897977, 682.4097155960059, 701.5755467941924, 5424.213489044067, 5456.48163424474, 5527.336719593674, 5636.520895723909, 5748.936446757363, 101236.49381753044, 104923.95076049143, 105453.78184872672, 106084.0, 108331.0, 74691.62654186803, 79441.0, 79453.60273198712, 81871.0, 91385.54307228421, 57201.71399142977, 72308.63845680738, 72707.0, 74254.0, 74327.0, 11924.403779811148, 12531.060170487068, 12597.244165350108, 12605.243685378906, 12612.936935315265, 35991.0, 36341.45487817738, 37190.8140459296, 37484.0, 38785.4182187273, 49659.25511117408, 49824.25263621121, 50355.24467133069, 50439.74780126076, 50539.49460505348, 15239.542813715607, 16014.119223442822, 16034.35862565531, 16081.437149699705, 16196.919015404848, 14439.566812995627, 17584.472465826046, 17766.200520976847, 17853.553661158574, 17937.641247175245, 15757.527274181793, 16116.919415402848, 16348.754768678242, 16446.83553164501, 16448.013119212887, 16074.276657550672, 16157.353705851634, 16305.347786088423, 16322.59193520124, 16433.67132657364, 13033.674158146123, 16476.67046659036, 16709.0, 16781.412650557173, 16839.41062062871, 11609.825852612386, 11692.94153529227, 11871.406429678655, 12026.037916966796, 12069.336186509827, 13113.868861311646, 13144.737105257651, 13165.341732913124, 13170.275634840176, 13226.537071202461], "value": 8253.071785748254, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1677.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 120.0, 120.0, 118.0, 123.0, 136.0, 108.0, 137.0, 180.0, 159.0], "value": 130.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 160.0, 176.0, 120.0, 136.0, 155.0, 117.0, 148.0, 128.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [255.0, 310.0, 295.0, 213.0, 212.0, 217.0, 207.0, 219.0, 217.0, 215.0], "value": 236.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 61.0, 61.0, 91.0, 60.0, 64.0, 61.0, 61.0, 76.0, 64.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 71.0, 90.0, 73.0, 73.0, 74.0, 87.0, 73.0, 73.0, 87.0], "value": 80.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 142.0, 124.0, 92.0, 91.0, 92.0, 93.0, 101.0, 101.0, 140.0], "value": 106.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 104.0, 101.0, 112.0, 101.0, 101.0, 114.0, 96.0, 166.0, 167.0], "value": 116.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 101.0, 102.0, 103.0, 105.0, 100.0, 166.0, 150.0, 104.0, 101.0], "value": 113.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 55.0, 54.0, 54.0, 53.0, 55.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 61.0, 68.0, 61.0, 77.0, 66.0, 61.0, 62.0, 63.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 93.0, 102.0, 88.0, 88.0, 89.0, 89.0, 87.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 158.0, 149.0, 162.0, 176.0, 171.0, 172.0, 227.0, 172.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 197.0, 210.0, 237.0, 199.0, 194.0, 199.0, 221.0, 218.0, 251.0], "value": 212.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 103.0, 106.0, 94.0, 97.0, 107.0, 101.0, 78.0, 59.0], "value": 89.6, "unit": "score"}]}]} 03:18:22 INFO - Return code: 0 03:18:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:22 ERROR - # TBPL SUCCESS # 03:18:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:18:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:18:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:18:22 INFO - 2017-04-10 03:18:22.523 screenresolution[2209:28395] starting screenresolution argv=screenresolution get 03:18:22 INFO - 2017-04-10 03:18:22.526 screenresolution[2209:28395] Display 0: 1600x1200x32@60 03:18:22 INFO - 2017-04-10 03:18:22.532 screenresolution[2210:28398] starting screenresolution argv=screenresolution list 03:18:22 INFO - Available Modes on Display 0 03:18:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:18:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:18:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:18:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:18:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:18:22 INFO - Intel Iris: 03:18:22 INFO - Chipset Model: Intel Iris 03:18:22 INFO - Type: GPU 03:18:22 INFO - Bus: Built-In 03:18:22 INFO - VRAM (Dynamic, Max): 1536 MB 03:18:22 INFO - Vendor: Intel (0x8086) 03:18:22 INFO - Device ID: 0x0a2e 03:18:22 INFO - Revision ID: 0x0009 03:18:22 INFO - Displays: 03:18:22 INFO - Display: 03:18:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:18:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:18:22 INFO - Display Serial Number: 1600x1200 60 03:18:22 INFO - Main Display: Yes 03:18:22 INFO - Mirror: Off 03:18:22 INFO - Online: Yes 03:18:22 INFO - Rotation: Supported 03:18:22 INFO - Return code: 0 03:18:22 INFO - Running post-action listener: _resource_record_post_action 03:18:22 INFO - [mozharness: 2017-04-10 10:18:22.777287Z] Finished run-tests step (success) 03:18:22 INFO - Running post-run listener: _resource_record_post_run 03:18:22 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 578048; Write bytes: 522868224; Read time: 7; Write time: 1649 03:18:22 INFO - TinderboxPrint: CPU usage
54.1% 03:18:22 INFO - TinderboxPrint: I/O read bytes / time
578,048 / 7 03:18:22 INFO - TinderboxPrint: I/O write bytes / time
522,868,224 / 1,649 03:18:22 INFO - TinderboxPrint: CPU idle
2,205.9 (45.9%) 03:18:22 INFO - TinderboxPrint: CPU system
967.9 (20.1%) 03:18:22 INFO - TinderboxPrint: CPU user
1,631.9 (34.0%) 03:18:22 INFO - TinderboxPrint: Swap in / out
207,765,504 / 0 03:18:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208517632; Write bytes: 206263808; Read time: 16034; Write time: 431 03:18:22 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 503808; Write bytes: 310390784; Read time: 5; Write time: 1188 03:18:23 INFO - Running post-run listener: _upload_blobber_files 03:18:23 INFO - Blob upload gear active. 03:18:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:23 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 03:18:23 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'] 03:18:23 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 03:18:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:18:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:24 INFO - (blobuploader) - INFO - Done attempting. 03:18:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:18:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:18:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:25 INFO - (blobuploader) - INFO - Done attempting. 03:18:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:18:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:26 INFO - (blobuploader) - INFO - Done attempting. 03:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:28 INFO - (blobuploader) - INFO - Done attempting. 03:18:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:28 INFO - Return code: 0 03:18:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/839ddd20a03e2a4327e690f3bed18fe3f81e8c7492052d9f6798d146ca7074ccefe6f1f52487d53a0ee2f41520f7faf67c303d8de0f6a1a19d322789496adf7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c5374f411ce32e9a754778418e46719f3ecbb00cc319a2f61446a79c1e0afd43290f3052f9b6c5653f2d4a935992076d18d5f35c4e50d6aba605488c73e998b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697b56ed2d4f76ffd842208a37e091e503632579d9a6043544799e241d825c4941be244ab5564f867441e8b4d83597a4abcf16f611a2bb96ff7edb38880fe4de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eee01791dbe6d11572aa7511a35dc1c01d2346810fe8f048a1fb37fda6a0bebc5bbbfc4ada82c3589e4dda90cd800a5d9f3063b2ff97701597ae0b1a9498d26"} 03:18:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:28 INFO - Contents: 03:18:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/839ddd20a03e2a4327e690f3bed18fe3f81e8c7492052d9f6798d146ca7074ccefe6f1f52487d53a0ee2f41520f7faf67c303d8de0f6a1a19d322789496adf7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c5374f411ce32e9a754778418e46719f3ecbb00cc319a2f61446a79c1e0afd43290f3052f9b6c5653f2d4a935992076d18d5f35c4e50d6aba605488c73e998b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697b56ed2d4f76ffd842208a37e091e503632579d9a6043544799e241d825c4941be244ab5564f867441e8b4d83597a4abcf16f611a2bb96ff7edb38880fe4de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eee01791dbe6d11572aa7511a35dc1c01d2346810fe8f048a1fb37fda6a0bebc5bbbfc4ada82c3589e4dda90cd800a5d9f3063b2ff97701597ae0b1a9498d26"} 03:18:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:28 INFO - Copying logs to upload dir... 03:18:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.703579 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-10 03:18:28.805125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 03:18:28.807817) ========= 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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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/839ddd20a03e2a4327e690f3bed18fe3f81e8c7492052d9f6798d146ca7074ccefe6f1f52487d53a0ee2f41520f7faf67c303d8de0f6a1a19d322789496adf7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c5374f411ce32e9a754778418e46719f3ecbb00cc319a2f61446a79c1e0afd43290f3052f9b6c5653f2d4a935992076d18d5f35c4e50d6aba605488c73e998b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697b56ed2d4f76ffd842208a37e091e503632579d9a6043544799e241d825c4941be244ab5564f867441e8b4d83597a4abcf16f611a2bb96ff7edb38880fe4de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eee01791dbe6d11572aa7511a35dc1c01d2346810fe8f048a1fb37fda6a0bebc5bbbfc4ada82c3589e4dda90cd800a5d9f3063b2ff97701597ae0b1a9498d26"} build_url:https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/b2QvwULhQAuTxbQWrsZQcA/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/839ddd20a03e2a4327e690f3bed18fe3f81e8c7492052d9f6798d146ca7074ccefe6f1f52487d53a0ee2f41520f7faf67c303d8de0f6a1a19d322789496adf7b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c5374f411ce32e9a754778418e46719f3ecbb00cc319a2f61446a79c1e0afd43290f3052f9b6c5653f2d4a935992076d18d5f35c4e50d6aba605488c73e998b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697b56ed2d4f76ffd842208a37e091e503632579d9a6043544799e241d825c4941be244ab5564f867441e8b4d83597a4abcf16f611a2bb96ff7edb38880fe4de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eee01791dbe6d11572aa7511a35dc1c01d2346810fe8f048a1fb37fda6a0bebc5bbbfc4ada82c3589e4dda90cd800a5d9f3063b2ff97701597ae0b1a9498d26"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 03:18:28.853999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 03:18:28.854417) ========= 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.dQoWe5w0f6/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.5FcYp0C2tI/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.005141 ========= master_lag: 1.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 03:18:30.670437) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 03:18:30.670772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 03:18:30.676257) ========= ========= Total master_lag: 2.43 =========