builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0272 starttime: 1491841412.63 results: success (0) buildid: 20170410074149 builduid: 2f652fb4d79f4687a43fd27a075c9804 revision: b1364675bdf5dffe63fd60373034293de0b513d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.629014) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.629514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.629828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.656542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.656845) ========= 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.UMcVmFgknR/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.2gJsmPUpF3/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 09:23:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2017-04-10 09:23:33 (13.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.769955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.770327) ========= 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.UMcVmFgknR/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.2gJsmPUpF3/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.026580 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:32.818964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 09:23:32.819351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1364675bdf5dffe63fd60373034293de0b513d5 --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 b1364675bdf5dffe63fd60373034293de0b513d5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UMcVmFgknR/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.2gJsmPUpF3/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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 09:23:33,216 truncating revision to first 12 chars 2017-04-10 09:23:33,216 Setting DEBUG logging. 2017-04-10 09:23:33,216 attempt 1/10 2017-04-10 09:23:33,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1364675bdf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 09:23:34,941 unpacking tar archive at: mozilla-central-b1364675bdf5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.001786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 09:23:34.845273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:34.845639) ========= script_repo_revision: b1364675bdf5dffe63fd60373034293de0b513d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:34.846111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:34.846420) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 09:23:34.866306) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-10 09:23:34.866609) ========= /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.UMcVmFgknR/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.2gJsmPUpF3/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:23:35 INFO - MultiFileLogger online at 20170410 09:23:35 in /builds/slave/test 09:23:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:23:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:35 INFO - {'append_to_log': False, 09:23:35 INFO - 'base_work_dir': '/builds/slave/test', 09:23:35 INFO - 'blob_upload_branch': 'Firefox', 09:23:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:35 INFO - 'branch': 'Firefox', 09:23:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:35 INFO - 'config_files': ('talos/mac_config.py',), 09:23:35 INFO - 'default_actions': ('clobber', 09:23:35 INFO - 'read-buildbot-config', 09:23:35 INFO - 'download-and-extract', 09:23:35 INFO - 'populate-webroot', 09:23:35 INFO - 'create-virtualenv', 09:23:35 INFO - 'install', 09:23:35 INFO - 'run-tests'), 09:23:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:35 INFO - 'download_minidump_stackwalk': True, 09:23:35 INFO - 'download_symbols': 'ondemand', 09:23:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:35 INFO - 'gecko_profile': False, 09:23:35 INFO - 'gecko_profile_interval': 0, 09:23:35 INFO - 'installer_path': 'installer.exe', 09:23:35 INFO - 'log_level': 'info', 09:23:35 INFO - 'log_name': 'talos', 09:23:35 INFO - 'log_to_console': True, 09:23:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:35 INFO - 'opt_config_files': (), 09:23:35 INFO - 'pip_index': False, 09:23:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:35 INFO - 'cmd': ('bash', 09:23:35 INFO - '-c', 09:23:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:35 INFO - 'enabled': True, 09:23:35 INFO - 'halt_on_failure': False, 09:23:35 INFO - 'name': 'check_screen_resolution'},), 09:23:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:35 INFO - 'cmd': ('bash', 09:23:35 INFO - '-c', 09:23:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:35 INFO - 'enabled': True, 09:23:35 INFO - 'halt_on_failure': False, 09:23:35 INFO - 'name': 'check_screen_resolution'},), 09:23:35 INFO - 'run_cmd_checks_enabled': True, 09:23:35 INFO - 'suite': 'dromaeojs-e10s', 09:23:35 INFO - 'system_bits': '32', 09:23:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:35 INFO - 'title': 't-yosemite-r7-0272', 09:23:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:35 INFO - 'use_talos_json': True, 09:23:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:35 INFO - 'work_dir': 'build'} 09:23:35 INFO - [mozharness: 2017-04-10 16:23:35.366616Z] Running clobber step. 09:23:35 INFO - Running pre-action listener: _resource_record_pre_action 09:23:35 INFO - Running main action method: clobber 09:23:35 INFO - rmtree: /builds/slave/test/build 09:23:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:37 INFO - Running post-action listener: _resource_record_post_action 09:23:37 INFO - [mozharness: 2017-04-10 16:23:37.841495Z] Finished clobber step (success) 09:23:37 INFO - [mozharness: 2017-04-10 16:23:37.841671Z] Running read-buildbot-config step. 09:23:37 INFO - Running pre-action listener: _resource_record_pre_action 09:23:37 INFO - Running main action method: read_buildbot_config 09:23:37 INFO - Using buildbot properties: 09:23:37 INFO - { 09:23:37 INFO - "project": "", 09:23:37 INFO - "product": "firefox", 09:23:37 INFO - "script_repo_revision": "production", 09:23:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:23:37 INFO - "repository": "", 09:23:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:23:37 INFO - "buildid": "20170410074149", 09:23:37 INFO - "pgo_build": "False", 09:23:37 INFO - "basedir": "/builds/slave/test", 09:23:37 INFO - "buildnumber": 40, 09:23:37 INFO - "slavename": "t-yosemite-r7-0272", 09:23:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:23:37 INFO - "platform": "yosemite_r7", 09:23:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:23:37 INFO - "branch": "mozilla-central", 09:23:37 INFO - "repo_path": "mozilla-central", 09:23:37 INFO - "revision": "b1364675bdf5dffe63fd60373034293de0b513d5", 09:23:37 INFO - "stage_platform": "macosx64", 09:23:37 INFO - "builduid": "2f652fb4d79f4687a43fd27a075c9804", 09:23:37 INFO - "slavebuilddir": "test" 09:23:37 INFO - } 09:23:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:23:37 INFO - Running post-action listener: _resource_record_post_action 09:23:37 INFO - [mozharness: 2017-04-10 16:23:37.845027Z] Finished read-buildbot-config step (success) 09:23:37 INFO - [mozharness: 2017-04-10 16:23:37.845117Z] Running download-and-extract step. 09:23:37 INFO - Running pre-action listener: _resource_record_pre_action 09:23:37 INFO - Running main action method: download_and_extract 09:23:37 INFO - mkdir: /builds/slave/test/build/tests 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:37 INFO - trying https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:23:37 INFO - Downloading https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:23:38 INFO - Downloaded 1325 bytes. 09:23:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:23:38 INFO - Using the following test package requirements: 09:23:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:23:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:23:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:23:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:23:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'jsshell-mac.zip'], 09:23:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:23:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:23:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:23:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:23:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:23:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:23:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:23:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:23:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:23:38 INFO - Fetch https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:23:40 INFO - Expected file size: 52580593 09:23:40 INFO - Obtained file size: 52580593 09:23:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:23:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:23:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:23:56 INFO - Fetch https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:23:58 INFO - Expected file size: 52580593 09:23:58 INFO - Obtained file size: 52580593 09:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:24:14 INFO - Expected file size: 14405596 09:24:14 INFO - Obtained file size: 14405596 09:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:15 INFO - trying https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:24:15 INFO - Downloading https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:24:17 INFO - Downloaded 70965514 bytes. 09:24:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:24:17 INFO - mkdir: /builds/slave/test/properties 09:24:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:17 INFO - Contents: 09:24:17 INFO - build_url:https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:24:17 INFO - Running post-action listener: _resource_record_post_action 09:24:17 INFO - Running post-action listener: set_extra_try_arguments 09:24:17 INFO - [mozharness: 2017-04-10 16:24:17.678124Z] Finished download-and-extract step (success) 09:24:17 INFO - [mozharness: 2017-04-10 16:24:17.678246Z] Running populate-webroot step. 09:24:17 INFO - Running pre-action listener: _resource_record_pre_action 09:24:17 INFO - Running main action method: populate_webroot 09:24:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:17 INFO - '--tppagecycles', 09:24:17 INFO - '7'], 09:24:17 INFO - 'tests': ['tsvgm']}}, 09:24:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['damp', 'tps']}, 09:24:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'tests': ['damp', 'tps']}, 09:24:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['dromaeo_dom']}, 09:24:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['basic_compositor_video']}, 09:24:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['a11yr', 09:24:17 INFO - 'ts_paint', 09:24:17 INFO - 'tpaint', 09:24:17 INFO - 'sessionrestore', 09:24:17 INFO - 'sessionrestore_no_auto_restore', 09:24:17 INFO - 'tabpaint']}, 09:24:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:17 INFO - 'ts_paint', 09:24:17 INFO - 'tpaint', 09:24:17 INFO - 'sessionrestore', 09:24:17 INFO - 'sessionrestore_no_auto_restore', 09:24:17 INFO - 'tabpaint']}, 09:24:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:17 INFO - 'ts_paint', 09:24:17 INFO - 'tpaint', 09:24:17 INFO - 'sessionrestore', 09:24:17 INFO - 'sessionrestore_no_auto_restore', 09:24:17 INFO - 'tabpaint']}, 09:24:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:17 INFO - 'ts_paint', 09:24:17 INFO - 'tpaint', 09:24:17 INFO - 'sessionrestore', 09:24:17 INFO - 'sessionrestore_no_auto_restore', 09:24:17 INFO - 'tabpaint']}, 09:24:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['a11yr', 09:24:17 INFO - 'ts_paint', 09:24:17 INFO - 'tpaint', 09:24:17 INFO - 'sessionrestore', 09:24:17 INFO - 'sessionrestore_no_auto_restore', 09:24:17 INFO - 'tabpaint']}, 09:24:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['a11yr', 09:24:17 INFO - 'ts_paint', 09:24:17 INFO - 'tpaint', 09:24:17 INFO - 'sessionrestore', 09:24:17 INFO - 'sessionrestore_no_auto_restore', 09:24:17 INFO - 'tabpaint']}, 09:24:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['tsvgx', 09:24:17 INFO - 'tsvgr_opacity', 09:24:17 INFO - 'tart', 09:24:17 INFO - 'tscrollx', 09:24:17 INFO - 'cart', 09:24:17 INFO - 'tsvg_static']}, 09:24:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:17 INFO - 'tsvgr_opacity', 09:24:17 INFO - 'tart', 09:24:17 INFO - 'tscrollx', 09:24:17 INFO - 'cart', 09:24:17 INFO - 'tsvg_static']}, 09:24:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'talos_options': ['--disable-e10s'], 09:24:17 INFO - 'tests': ['tp5o']}, 09:24:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:24:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'talos_options': ['--disable-e10s', 09:24:17 INFO - '--xperf_path', 09:24:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:17 INFO - 'tests': ['tp5n']}, 09:24:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:24:17 INFO - 'talos_options': ['--xperf_path', 09:24:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:17 INFO - 'tests': ['tp5n']}}, 09:24:17 INFO - 'talos.zip': {'path': '', 09:24:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:17 INFO - Running post-action listener: _resource_record_post_action 09:24:17 INFO - [mozharness: 2017-04-10 16:24:17.696718Z] Finished populate-webroot step (success) 09:24:17 INFO - [mozharness: 2017-04-10 16:24:17.696852Z] Running create-virtualenv step. 09:24:17 INFO - Running pre-action listener: _resource_record_pre_action 09:24:17 INFO - Running main action method: create_virtualenv 09:24:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:24:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:17 INFO - Using real prefix '/tools/python27' 09:24:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:21 INFO - Installing pip.................done. 09:24:21 INFO - Return code: 0 09:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:24:21 INFO - Reading from file tmpfile_stdout 09:24:21 INFO - Output received: 09:24:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:24:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 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 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:21 INFO - 'HOME': '/Users/cltbld', 09:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:21 INFO - 'LOGNAME': 'cltbld', 09:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:21 INFO - 'MOZ_NO_REMOTE': '1', 09:24:21 INFO - 'NO_EM_RESTART': '1', 09:24:21 INFO - 'PAGER': '/bin/cat', 09:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:21 INFO - 'PWD': '/builds/slave/test', 09:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:21 INFO - 'SHELL': '/bin/bash', 09:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:21 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:21 INFO - 'USER': 'cltbld', 09:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:21 INFO - 'XPC_FLAGS': '0x0', 09:24:21 INFO - 'XPC_SERVICE_NAME': '0', 09:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:24:21 INFO - Cleaning up... 09:24:21 INFO - Return code: 0 09:24:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 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 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:21 INFO - 'HOME': '/Users/cltbld', 09:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:21 INFO - 'LOGNAME': 'cltbld', 09:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:21 INFO - 'MOZ_NO_REMOTE': '1', 09:24:21 INFO - 'NO_EM_RESTART': '1', 09:24:21 INFO - 'PAGER': '/bin/cat', 09:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:21 INFO - 'PWD': '/builds/slave/test', 09:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:21 INFO - 'SHELL': '/bin/bash', 09:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:21 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:21 INFO - 'USER': 'cltbld', 09:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:21 INFO - 'XPC_FLAGS': '0x0', 09:24:21 INFO - 'XPC_SERVICE_NAME': '0', 09:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:22 INFO - Downloading/unpacking psutil>=3.1.1 09:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:25 INFO - Installing collected packages: psutil 09:24:25 INFO - Running setup.py install for psutil 09:24:25 INFO - building 'psutil._psutil_osx' extension 09:24:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:24:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:24:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:24:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:24:26 INFO - building 'psutil._psutil_posix' extension 09:24:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:24:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:26 INFO - ^ 09:24:26 INFO - 1 warning generated. 09:24:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:24:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:26 INFO - Successfully installed psutil 09:24:26 INFO - Cleaning up... 09:24:26 INFO - Return code: 0 09:24:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:26 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 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:26 INFO - 'HOME': '/Users/cltbld', 09:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:26 INFO - 'LOGNAME': 'cltbld', 09:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:26 INFO - 'MOZ_NO_REMOTE': '1', 09:24:26 INFO - 'NO_EM_RESTART': '1', 09:24:26 INFO - 'PAGER': '/bin/cat', 09:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:26 INFO - 'PWD': '/builds/slave/test', 09:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:26 INFO - 'SHELL': '/bin/bash', 09:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:26 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:26 INFO - 'USER': 'cltbld', 09:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:26 INFO - 'XPC_FLAGS': '0x0', 09:24:26 INFO - 'XPC_SERVICE_NAME': '0', 09:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:30 INFO - Installing collected packages: mozsystemmonitor 09:24:30 INFO - Running setup.py install for mozsystemmonitor 09:24:30 INFO - Successfully installed mozsystemmonitor 09:24:30 INFO - Cleaning up... 09:24:30 INFO - Return code: 0 09:24:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:31 INFO - 'HOME': '/Users/cltbld', 09:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:31 INFO - 'LOGNAME': 'cltbld', 09:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:31 INFO - 'MOZ_NO_REMOTE': '1', 09:24:31 INFO - 'NO_EM_RESTART': '1', 09:24:31 INFO - 'PAGER': '/bin/cat', 09:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:31 INFO - 'PWD': '/builds/slave/test', 09:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:31 INFO - 'SHELL': '/bin/bash', 09:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:31 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:31 INFO - 'USER': 'cltbld', 09:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:31 INFO - 'XPC_FLAGS': '0x0', 09:24:31 INFO - 'XPC_SERVICE_NAME': '0', 09:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:34 INFO - warning: no files found matching '*.txt' 09:24:34 INFO - no previously-included directories found matching 'build' 09:24:34 INFO - no previously-included directories found matching 'dist' 09:24:34 INFO - no previously-included directories found matching '.git*' 09:24:34 INFO - Installing collected packages: jsonschema, functools32 09:24:34 INFO - Running setup.py install for functools32 09:24:34 INFO - warning: no files found matching '*.txt' 09:24:34 INFO - no previously-included directories found matching 'build' 09:24:34 INFO - no previously-included directories found matching 'dist' 09:24:34 INFO - no previously-included directories found matching '.git*' 09:24:34 INFO - Successfully installed jsonschema functools32 09:24:34 INFO - Cleaning up... 09:24:34 INFO - Return code: 0 09:24:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:34 INFO - 'HOME': '/Users/cltbld', 09:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:34 INFO - 'LOGNAME': 'cltbld', 09:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:34 INFO - 'MOZ_NO_REMOTE': '1', 09:24:34 INFO - 'NO_EM_RESTART': '1', 09:24:34 INFO - 'PAGER': '/bin/cat', 09:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:34 INFO - 'PWD': '/builds/slave/test', 09:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:34 INFO - 'SHELL': '/bin/bash', 09:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:34 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:34 INFO - 'USER': 'cltbld', 09:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:34 INFO - 'XPC_FLAGS': '0x0', 09:24:34 INFO - 'XPC_SERVICE_NAME': '0', 09:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:35 INFO - Cleaning up... 09:24:35 INFO - Return code: 0 09:24:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:35 INFO - 'HOME': '/Users/cltbld', 09:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:35 INFO - 'LOGNAME': 'cltbld', 09:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:35 INFO - 'MOZ_NO_REMOTE': '1', 09:24:35 INFO - 'NO_EM_RESTART': '1', 09:24:35 INFO - 'PAGER': '/bin/cat', 09:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:35 INFO - 'PWD': '/builds/slave/test', 09:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:35 INFO - 'SHELL': '/bin/bash', 09:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:35 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:35 INFO - 'USER': 'cltbld', 09:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:35 INFO - 'XPC_FLAGS': '0x0', 09:24:35 INFO - 'XPC_SERVICE_NAME': '0', 09:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:39 INFO - Downloading docopt-0.6.1.tar.gz 09:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:39 INFO - Running setup.py install for blobuploader 09:24:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:39 INFO - Running setup.py install for requests 09:24:40 INFO - Running setup.py install for docopt 09:24:40 INFO - Successfully installed blobuploader requests docopt 09:24:40 INFO - Cleaning up... 09:24:40 INFO - Return code: 0 09:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:40 INFO - 'HOME': '/Users/cltbld', 09:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:40 INFO - 'LOGNAME': 'cltbld', 09:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:40 INFO - 'MOZ_NO_REMOTE': '1', 09:24:40 INFO - 'NO_EM_RESTART': '1', 09:24:40 INFO - 'PAGER': '/bin/cat', 09:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:40 INFO - 'PWD': '/builds/slave/test', 09:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:40 INFO - 'SHELL': '/bin/bash', 09:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:40 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:40 INFO - 'USER': 'cltbld', 09:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:40 INFO - 'XPC_FLAGS': '0x0', 09:24:40 INFO - 'XPC_SERVICE_NAME': '0', 09:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-5utG1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-nBsP63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:40 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-W0fT0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-XxJvjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qUlLT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-AgKq9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-lD7EBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-6LJ9cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-4U_een-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-0_Ru2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-u5gsjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:41 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-c7KAm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:42 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-nxZKw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:42 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-jefpTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:42 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-oZpur7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:42 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-tACmbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:42 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-TG3rtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:42 INFO - Running setup.py install for manifestparser 09:24:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:42 INFO - Running setup.py install for mozcrash 09:24:42 INFO - Running setup.py install for mozdebug 09:24:42 INFO - Running setup.py install for mozdevice 09:24:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozfile 09:24:43 INFO - Running setup.py install for mozhttpd 09:24:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozinfo 09:24:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozInstall 09:24:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:43 INFO - Running setup.py install for mozleak 09:24:43 INFO - Running setup.py install for mozlog 09:24:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for moznetwork 09:24:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for mozprocess 09:24:44 INFO - Running setup.py install for mozprofile 09:24:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for mozrunner 09:24:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for mozscreenshot 09:24:44 INFO - Running setup.py install for moztest 09:24:44 INFO - Running setup.py install for mozversion 09:24:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:45 INFO - Cleaning up... 09:24:45 INFO - Return code: 0 09:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:45 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 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:45 INFO - 'HOME': '/Users/cltbld', 09:24:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:45 INFO - 'LOGNAME': 'cltbld', 09:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:45 INFO - 'MOZ_NO_REMOTE': '1', 09:24:45 INFO - 'NO_EM_RESTART': '1', 09:24:45 INFO - 'PAGER': '/bin/cat', 09:24:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:45 INFO - 'PWD': '/builds/slave/test', 09:24:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:45 INFO - 'SHELL': '/bin/bash', 09:24:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:45 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:45 INFO - 'USER': 'cltbld', 09:24:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:45 INFO - 'XPC_FLAGS': '0x0', 09:24:45 INFO - 'XPC_SERVICE_NAME': '0', 09:24:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-jvCnsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-MdsK7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-i3QfLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-dtDAIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:45 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)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qwiACY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:45 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JVJ9QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9lcn6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-nZnZoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-5DgBMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-1oDF5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-j26Ty6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9ijKPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-o4Jb3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-CVwNfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:46 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-WaDhDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:47 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-kwccta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:47 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-R5tMeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:47 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)) 09:24:47 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)) 09:24:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:49 INFO - Downloading blessings-1.6.tar.gz 09:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:49 INFO - Installing collected packages: blessings 09:24:49 INFO - Running setup.py install for blessings 09:24:50 INFO - Successfully installed blessings 09:24:50 INFO - Cleaning up... 09:24:50 INFO - Return code: 0 09:24:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:50 INFO - Reading from file tmpfile_stdout 09:24:50 INFO - Current package versions: 09:24:50 INFO - blessings == 1.6 09:24:50 INFO - blobuploader == 1.2.4 09:24:50 INFO - docopt == 0.6.1 09:24:50 INFO - functools32 == 3.2.3-2 09:24:50 INFO - jsonschema == 2.5.1 09:24:50 INFO - manifestparser == 1.1 09:24:50 INFO - mozInstall == 1.12 09:24:50 INFO - mozcrash == 1.0 09:24:50 INFO - mozdebug == 0.1 09:24:50 INFO - mozdevice == 0.50 09:24:50 INFO - mozfile == 1.2 09:24:50 INFO - mozhttpd == 0.7 09:24:50 INFO - mozinfo == 0.9 09:24:50 INFO - mozleak == 0.1 09:24:50 INFO - mozlog == 3.4 09:24:50 INFO - moznetwork == 0.27 09:24:50 INFO - mozprocess == 0.25 09:24:50 INFO - mozprofile == 0.28 09:24:50 INFO - mozrunner == 6.13 09:24:50 INFO - mozscreenshot == 0.1 09:24:50 INFO - mozsystemmonitor == 0.3 09:24:50 INFO - moztest == 0.8 09:24:50 INFO - mozversion == 1.4 09:24:50 INFO - psutil == 3.1.1 09:24:50 INFO - requests == 1.2.3 09:24:50 INFO - wsgiref == 0.1.2 09:24:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:50 INFO - 'HOME': '/Users/cltbld', 09:24:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:50 INFO - 'LOGNAME': 'cltbld', 09:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:50 INFO - 'MOZ_NO_REMOTE': '1', 09:24:50 INFO - 'NO_EM_RESTART': '1', 09:24:50 INFO - 'PAGER': '/bin/cat', 09:24:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:50 INFO - 'PWD': '/builds/slave/test', 09:24:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:50 INFO - 'SHELL': '/bin/bash', 09:24:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:50 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:50 INFO - 'USER': 'cltbld', 09:24:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:50 INFO - 'XPC_FLAGS': '0x0', 09:24:50 INFO - 'XPC_SERVICE_NAME': '0', 09:24:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:24:50 INFO - Cleaning up... 09:24:50 INFO - Return code: 0 09:24:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101b4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1101b7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4a1d95280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, '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.UMcVmFgknR/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.2gJsmPUpF3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:24:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:24:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:50 INFO - 'HOME': '/Users/cltbld', 09:24:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:50 INFO - 'LOGNAME': 'cltbld', 09:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:50 INFO - 'MOZ_NO_REMOTE': '1', 09:24:50 INFO - 'NO_EM_RESTART': '1', 09:24:50 INFO - 'PAGER': '/bin/cat', 09:24:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:50 INFO - 'PWD': '/builds/slave/test', 09:24:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:50 INFO - 'SHELL': '/bin/bash', 09:24:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:24:50 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:24:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:50 INFO - 'USER': 'cltbld', 09:24:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:50 INFO - 'XPC_FLAGS': '0x0', 09:24:50 INFO - 'XPC_SERVICE_NAME': '0', 09:24:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:51 INFO - Cleaning up... 09:24:51 INFO - Return code: 0 09:24:51 INFO - Running post-action listener: _resource_record_post_action 09:24:51 INFO - Running post-action listener: _start_resource_monitoring 09:24:51 INFO - Starting resource monitoring. 09:24:51 INFO - [mozharness: 2017-04-10 16:24:51.084235Z] Finished create-virtualenv step (success) 09:24:51 INFO - [mozharness: 2017-04-10 16:24:51.085249Z] Running install step. 09:24:51 INFO - Running pre-action listener: _resource_record_pre_action 09:24:51 INFO - Running main action method: install 09:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:51 INFO - Reading from file tmpfile_stdout 09:24:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:51 INFO - Reading from file tmpfile_stdout 09:24:51 INFO - Output received: 09:24:51 INFO - Usage: mozinstall [options] installer 09:24:51 INFO - Options: 09:24:51 INFO - -h, --help show this help message and exit 09:24:51 INFO - -d DEST, --destination=DEST 09:24:51 INFO - Directory to install application into. [default: 09:24:51 INFO - "/builds/slave/test"] 09:24:51 INFO - --app=APP Application being installed. [default: firefox] 09:24:51 INFO - mkdir: /builds/slave/test/build/application 09:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:25:11 INFO - Reading from file tmpfile_stdout 09:25:11 INFO - Output received: 09:25:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:25:11 INFO - Running post-action listener: _resource_record_post_action 09:25:11 INFO - [mozharness: 2017-04-10 16:25:11.059994Z] Finished install step (success) 09:25:11 INFO - [mozharness: 2017-04-10 16:25:11.060169Z] Running run-tests step. 09:25:11 INFO - Running pre-action listener: _resource_record_pre_action 09:25:11 INFO - Running main action method: run_tests 09:25:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:11 INFO - 2017-04-10 09:25:11.075 screenresolution[1628:7360] starting screenresolution argv=screenresolution get 09:25:11 INFO - 2017-04-10 09:25:11.077 screenresolution[1628:7360] Display 0: 1600x1200x32@60 09:25:11 INFO - 2017-04-10 09:25:11.083 screenresolution[1629:7363] starting screenresolution argv=screenresolution list 09:25:11 INFO - Available Modes on Display 0 09:25:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:11 INFO - Intel Iris: 09:25:11 INFO - Chipset Model: Intel Iris 09:25:11 INFO - Type: GPU 09:25:11 INFO - Bus: Built-In 09:25:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:11 INFO - Vendor: Intel (0x8086) 09:25:11 INFO - Device ID: 0x0a2e 09:25:11 INFO - Revision ID: 0x0009 09:25:11 INFO - Displays: 09:25:11 INFO - Display: 09:25:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:11 INFO - Display Serial Number: 1600x1200 60 09:25:11 INFO - Main Display: Yes 09:25:11 INFO - Mirror: Off 09:25:11 INFO - Online: Yes 09:25:11 INFO - Rotation: Supported 09:25:11 INFO - Return code: 0 09:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:11 INFO - Python 2.7.3 09:25:11 INFO - Return code: 0 09:25:11 INFO - grabbing minidump binary from tooltool 09:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff92d30>, '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 0x10feb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff87be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:25:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:25:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:25:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:11 INFO - Return code: 0 09:25:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:11 INFO - ENV: RUST_BACKTRACE is now 1 09:25:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:11 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/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:25:11 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/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0272 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:25:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UMcVmFgknR/Render', 09:25:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:11 INFO - 'HOME': '/Users/cltbld', 09:25:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:11 INFO - 'LOGNAME': 'cltbld', 09:25:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:11 INFO - 'MOZ_NO_REMOTE': '1', 09:25:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:11 INFO - 'NO_EM_RESTART': '1', 09:25:11 INFO - 'PAGER': '/bin/cat', 09:25:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:11 INFO - 'PWD': '/builds/slave/test', 09:25:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:11 INFO - 'RUST_BACKTRACE': '1', 09:25:11 INFO - 'SHELL': '/bin/bash', 09:25:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2gJsmPUpF3/Listeners', 09:25:11 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 09:25:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:11 INFO - 'USER': 'cltbld', 09:25:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:11 INFO - 'XPC_FLAGS': '0x0', 09:25:11 INFO - 'XPC_SERVICE_NAME': '0', 09:25:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:11 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/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:25:11 INFO - mozversion application_buildid: 20170410074149 09:25:11 INFO - mozversion application_changeset: b1364675bdf5dffe63fd60373034293de0b513d5 09:25:11 INFO - mozversion application_display_name: Nightly 09:25:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:11 INFO - mozversion application_name: Firefox 09:25:11 INFO - mozversion application_remotingname: firefox 09:25:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:25:11 INFO - mozversion application_vendor: Mozilla 09:25:11 INFO - mozversion application_version: 55.0a1 09:25:11 INFO - mozversion platform_buildid: 20170410074149 09:25:11 INFO - mozversion platform_changeset: b1364675bdf5dffe63fd60373034293de0b513d5 09:25:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:25:11 INFO - mozversion platform_version: 55.0a1 09:25:11 INFO - using testdate: 1491841511 09:25:11 INFO - actual date: 1491841511 09:25:11 INFO - starting webserver on 'localhost:49238' 09:25:11 INFO - SUITE-START | Running 2 tests 09:25:11 INFO - TEST-START | dromaeo_css 09:25:11 INFO - operating with platform_type : mac_ 09:25:11 INFO - Initialising browser for dromaeo_css test... 09:25:11 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpAr7cVZ/profile http://localhost:49238/getInfo.html) 09:25:14 INFO - PID 1639 | 2017-04-10 09:25:14.775 plugin-container[1641:7539] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 09:25:14 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:14 INFO - PID 1639 | 2017-04-10 09:25:14.777 plugin-container[1641:7539] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 09:25:14 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:14 INFO - PID 1639 | 2017-04-10 09:25:14.777 plugin-container[1641:7539] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:25:14 INFO - PID 1639 | __metrics Screen width/height:1600/1200 09:25:14 INFO - PID 1639 | colorDepth:24 09:25:14 INFO - PID 1639 | Browser inner width/height: 1024/689 09:25:14 INFO - PID 1639 | __metrics 09:25:14 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:25:15 INFO - TEST-INFO | 1639: exit 0 09:25:15 INFO - Browser initialized. 09:25:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:15 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpAr7cVZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:18 INFO - PID 1642 | 2017-04-10 09:25:18.592 plugin-container[1643:7671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 09:25:18 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:18 INFO - PID 1642 | 2017-04-10 09:25:18.593 plugin-container[1643:7671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 09:25:18 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:25:18 INFO - PID 1642 | 2017-04-10 09:25:18.593 plugin-container[1643:7671] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:25:28 INFO - PID 1642 | RSS: Main: 234565632 09:25:28 INFO - PID 1642 | 09:28:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 09:28:33 INFO - PID 1642 | RSS: Main: 252518400 09:28:33 INFO - PID 1642 | 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 09:30:16 INFO - PID 1642 | 09:30:16 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:30:16 INFO - PID 1642 | Full stack: 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 09:30:16 INFO - PID 1642 | 09:30:16 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:30:16 INFO - PID 1642 | Full stack: 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 09:30:16 INFO - PID 1642 | 09:30:16 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:30:16 INFO - PID 1642 | Full stack: 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | ************************* 09:30:16 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 09:30:16 INFO - PID 1642 | 09:30:16 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:30:16 INFO - PID 1642 | Full stack: 09:30:16 INFO - PID 1642 | ************************* 09:31:35 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 09:31:36 INFO - PID 1642 | RSS: Main: 260435968 09:31:36 INFO - PID 1642 | 09:34:37 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 09:34:38 INFO - PID 1642 | RSS: Main: 272617472 09:34:38 INFO - PID 1642 | 09:37:40 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 09:37:41 INFO - PID 1642 | RSS: Main: 265011200 09:37:41 INFO - PID 1642 | 09:40:43 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 09:40:44 INFO - PID 1642 | RSS: Main: 275378176 09:40:44 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 09:43:46 INFO - PID 1642 | RSS: Main: 270077952 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | __start_tp_report 09:43:46 INFO - PID 1642 | _x_x_mozilla_page_load 09:43:46 INFO - PID 1642 | _x_x_mozilla_page_load_details 09:43:46 INFO - PID 1642 | |i|pagename|runs| 09:43:46 INFO - PID 1642 | |0;dojo.html;3478.808665523396;3536.0982949347926;3585.049961760132;3597.9280414391715;3604.2250916053054;6059.606125601844;6137.846553836151;6145.231846019247;6192.287886893008;6221.875562488747;6077.78727744529;6102.64073755963;6107.4197951194565;6119;6234.345393733661;5305.912287980955;5418.810341638044;5424.0779067558515;5483.75323110461;5498.147787093007;5377.46225377463;5433.891322173554;5505.697186654733;5533.391326954052;5549.5837812164045;5477.534409575191;5495.917561236584;5502.504774570288;5510.752016159283;5520.779168833242;5278.498542638443;5334.626576139672;5345.812896548602;5378.381486129067;5449.809256675997;4437.334399840018;5315.468453154654;5317.627766056377;5362.624616276862;5410.945890541084;5041.269015992661;5904.2029326040865;6084.482818960394;6216.005439129717;6238.1266622672865;6358.809235722936;6401.519886008568;6541.672916354163;6576.4410025147445;6590.637514936677;5407.783248769035;6660.666966651648;6726.058351830748;6740.797776066725;6790.728370865159;4821.7589120543835;6286.9056964145575;6329.905051424278;6348.587341822767;6349.206349206349;6485.675716214265;6674.098996635489;6740.898886516707;6873.896891546631;6919.37725604698;6314;6401.58389704677;6449.774257900951;6501.577397469149;6503.349665033459;6438.581492202992;6463.515236357292;6610.041543976096;6670.433013193836;6695.263521012685;5407.297051383295;6537.803865884031;6574.5397822152945;6580.901286480706;6616.404523592803;6241.438270555672;6399.200099987502;6571.704273307712;6580.078788969548;6589.275179730226;5232.319798426181;5305.44292849253;5328.626996110235;5378.757955891994;5394.056040192951;4705.435347758223;4712.458067322234;4716.127516409475;4717.127331443694;4760.619150467955;6134.539909506805;6348.238211414568;6359.459445947054;6366.331535188739;6380.7447702091395;6393.904091438632;6412.64730439821;6596.340365963461;6611.173603299588;6658.83352916181;6319.304876463585;6353.491720662336;6354.968225158845;6367.267764207176;6382.648954307465;5736.996025695486;5838.7080645967535;5848.4151584841175;5879.412058794172;5936.881262374728;5660.603757736919;6019.70576326092;6502.349765023459;6747.595144291358;6785.796426107225;6703;6721.899171512529;6724.7982560521305;6729.798106056826;6741.865162696817;6828.863422731617;6860.725570977105;6866.313368663094;6906.482013848881;6912.239653638197;6251.718672659832;6356.4279214870885;6413.486921046212;6518.511111666549;6636.170478690164;6468.8059358219325;6679.6994135265;6687.832804179934;6689.966550167413;6706.262311145672;6442;6454.677266136769;6471.385218404433;6483.157189565326;6484.643344615903;6215.564910456405;6334.398232167937;6396.10454536356;6481.4166724994975;6502.187226596676;6223.222097237845;6240.438360547572;6369.108324834434;6375.362463753588;6389.616623002449;6496.090547323284;6505.902411463737;6509.4792416605615;6526.608403495806;6541.443977261986;6183.5671502994355;6212.782552610818;6269.341719119427;6281.528885333527;6348.77779277723 09:43:46 INFO - PID 1642 | |1;ext.html;676.9086173366594;799.3445374792668;832.9708460203894;1271.294431590468;1289.1620446709637;37040.888773336774;38012.42981355282;38024.42963355552;38090;39025.60974390252;37863.621363786355;37930.81034594823;38200.752936000405;38265.426018609745;38289.42565861507;8029.197080291968;8491.872621910676;8687.609057592392;8708.564571771418;8746.606402711894;7513.474056816025;8658.393912426132;8791.164839340252;8797.032326444087;8799.516026618534;8717.694880679177;8759.562021898912;8821.470711757314;8825.823483530325;8839.07189745077;8747.912520874774;8781.692640757576;8782.12178782123;8783.165599268123;8819.029906710224;8418;8486.872696909551;8498.532580708059;8519.190676885686;8550.315974722007;36856;36911.63088369109;36915;36978.44532332017;37015.81492092522;3594.263176048904;3595.9640403596154;3645.8906232813056;3647.0882279430143;3652;30329;30445.23886902823;30495.542566861513;30526.84736576325;30597.541036884464;3132.6554079051284;3161.8260995645232;3163.2566346908457;3166.62000559932;3179.9046028619177;221429;222655;248171;263382;264034;47580.7620961893;47584.286235706495;47667;47685.52314476811;47849.76075119602;49401.75299123481;49498.75250623724;49557.752211238716;49590.75204624026;49598.76003099951;14101.576952691436;14208.57914208571;14249.643758905902;14271.930570067281;14283.714325713427;11606.76786464266;11663.88336116628;11765.176437649283;11789.233699809485;11814.350210738492;13440.32798360078;13449.865501345057;13462.259575723234;13472.854807341486;13539.661508462368;5295.12630415977;5394.462578165204;5610.635308704921;5936.7440372658975;5966.136254597817;940.6519587752439;965.4979410706534;1037.1702637889657;1066.5200659703164;1069.4332004037872;21326.573468530853;21764.694118352632;23582.17462388808;24763.876180618983;24929.127480538456;987.9654212102541;1058.5448257249457;1104.6851647280487;1155.070168514354;1156.988430115705;10741.89258107409;12507.93746031264;12530.37348132608;12559.183653062704;12684;334015;336546;336698;340993;341104;41798.37302440405;53443.465565344624;53817;53888.461115388345;54016;1455.294182321573;1513.1904431129512;1528.335174199227;1536.9923150384177;1539.1611571693454;23720.644190336814;23982.800859957282;24013.75986240115;24105.879470602536;24153.396165096012;31412.37175256528;37972.81013594914;37982.81008594939;38060.238795223384;38070;291432;291787;292374;294349.5282523574;294655;31367.84316078405;33485.66514334923;33869.491957620165;34618.65381346154;34653.48019779756;44529;45289.54710452853;45473.77263113796;45541.54458455506;45606.08787824291;29992.85003574968;30720.84639576788;30889.536656950615;31217.219569510944;31401.685983139876;27772;28341.574876377283;30398.240043999078;30913.8454307727;31144.197022268105;36050.63949360473;36761.63238367689;37213.06967325838;37286;37341.69304074344;26278.343041424116;29561.704382955893;31528.527072094395;32037.839810800797;32116.67883321137;20061.595688301677;22585.548289034457;23644.408889777893;24527.509449810546;24844.627330589694 09:43:46 INFO - PID 1642 | |2;jquery.html;431.874756320667;432.5768222547818;436.7183166857377;440.0758407344576;461.2827053931136;19805.306814261523;21450.89274553627;21884;22046.88976555119;22222.88888555555;18548.536286592844;21987.450313742123;22400.439989000282;22950.426239344026;23430.179943701973;6136.110264011716;6370.362963703639;6371.235451745773;6377.1825029866495;6384.5211609129265;5990.341062483123;6249.156363890885;6274.937250627504;6294.213223347082;6296.401841825019;6189.071639254125;6189.071639254125;6235;6240.188775459184;6257.968710156443;6096.1770161028135;6197.6901154942525;6225.8132256032395;6234.283057448383;6254.186955695776;5430.891382172374;5541.584381171388;5542.140968149944;5564.638298510625;5567.886422715433;26895.462090758272;27293.72706272932;27546.311342216406;27547;27902.720972790215;2166.8266538676867;2224.7663995280586;2229.3869185973826;2243.8317126215434;2246.0791075658904;17711;17716.379926702502;17753.11234438273;18257.269709211614;18357.449276521726;2183.0721943174244;2185.8360622953182;2243.0467051503047;2245.0682966568857;2245.2253972379503;135138;144675;154777.09866533615;155082;156961.43038569696;10632.362058276529;11850.940745296219;12316.445759940823;12888.420021099073;13009.349532523336;16275.593110172103;16540.503784886474;16611.584710382336;16619.252133654016;16642.916785416237;7606;8767.254783343487;9052.864207036768;9077.409968352036;9126.08739126082;8484.32125429964;8572.91427085721;8628.956855215683;8783.429077109968;8785.780355491164;7804.0635123785505;7936.127026027132;7996.24035716606;8005.199480051948;8021.197880212048;1846.3906910719431;2050.8872012039483;2179.3244094330807;2190.5290362571805;2194.9561008779733;964.8793900762405;970.8689376876001;975.1808480876098;975.6633961283346;989.9109080182818;20741.58516829655;20765.58468830615;20875.37373878786;21448.892755536122;27017.729822701913;836.928731224022;1023.2632504596678;1025.9384436933808;1047.9476026198658;1055.7888422315414;10818;10979.725506862393;11109.500072496758;11114.277571957797;11190.720231994264;666701;667569;690475;693728;703548;157631.8473630521;159755;163038;164406;169550;1228.1832581333313;1237.6410840856051;1258.157034786695;1260.1116213069763;1263.1473755215377;18326.450206493828;18354.90822545879;18358;18398.816011840245;18630;46228;48677.75661121672;54578.72710636421;66761.99857002246;69419;84386.57806710927;89138;89353;89599.55200223956;92657;8690.652373905226;8821.955890220508;8836.646534138563;9180.54097295146;9370.625174993196;12655.240685558896;13495.460181593018;14355.497557585435;14528.709425811636;14655.193964332064;10488.39908926507;12223.69440763988;12242.632721018384;12368.876311236772;12389.442475088823;10203.540840662337;11303.886961130283;11590.826137608112;11618;11850.703732406759;11316.547338106713;11647;12036.037117030792;12084.637460876187;12086.697832554257;8878.422902511316;8951.73144805657;9026.729198124067;9054.185123338932;9364.906350936404;11964.46159922823;12007.399630018639;12169.20900141488;12212.267263964191;12231.571894983634 09:43:46 INFO - PID 1642 | |3;mootools.html;1267.2649863079412;1364.3792074606054;1417.7944198091277;1425.1164278147544;1437.7268319019392;9412.764680882972;11600.3039817611;11679.182457227997;11840.111991600621;12011.039116870652;11178.04986576142;11245.943770281157;11363.715907102327;11367.261128026672;11399.145064120203;2469.259222233332;2520.18094119411;2520.773130418262;2520.848749075052;2527.797776177901;2264.762199969004;2371.727251366098;2431.9392015199674;2453.0065323543904;2467.346153269385;2443.1204766284122;2467.111839737693;2467.2721547143547;2493.551160791057;2496.6005439129744;2206.3932418584936;2272.9090036782354;2273.965345767672;2368.455255291293;2439.878006099688;2275.419767959176;2369.2418426103654;2444.6088625819784;2461.2739241923496;2470.9258722238183;11510;11554.306741595532;11557.017653499379;11563.826542601868;11565.768684626344;6538.476921846289;6791.864162716718;6796.150481189851;6807.965960170217;6808.863822723518;3684.465752465904;4079.938800917989;4275.46556680415;4339.392485052095;4463.464384273875;1236.4683186229918;1244.3467179730624;1271.790154624486;1281.423359488234;1284.1396264502712;12809;16070.196490175444;16222.918885405616;16330.75503867443;16356.918215408965;4353.455818022747;5433.673979561239;5517.393086760453;5762.2509073820975;5941.138534912414;11385;12081.75836483283;12201.755964880831;12260.44827982743;12265.816012759815;6541.836454088686;6602.603843769293;6604.306547812506;6609.471242300604;6617.53677242598;5420.24116623673;6067.484263837535;6124.173236613089;6241.469475094577;6255.374462553708;4315.956840431555;4417.580329868657;4508.120916421332;4539.931901021488;4551.658625603093;1091.4215465803138;1314.9934250328688;1323.7749582570987;1331.633800704814;1332.8134061231435;772.2624893226955;775.918528554505;796.8924195233685;798.078219656298;807.9030516338076;6563.474922006228;6966.5471744336455;6980.267071957372;7151.471237785174;7287.781366559012;869.599984007351;891.5987805487426;897.6947837735202;918.196577994255;928.331601247101;3709.536307961505;4097.549269580344;4207.200631879933;4267.4025636410925;4363.978180109143;14606.634834129232;15066;15189.316480758393;15202.619934501727;15220.238988050553;14666.413343466354;15028;15070.623234419008;15081;15092.698146037237;9278.536073196448;9749.463779492196;10484.685459436228;10848.67453976382;11023.61417350389;6264.21697287839;7030.483034250424;7160.928390716234;7187.604681742554;7214.494985350975;12837.29394883253;12837.87162128404;12861.549845755353;13260.138091024053;13446.529371471952;13529.729405412034;13669.97475189345;13813.861861381258;13833.515826946008;13958.37187326593;7843.372530197685;8799.648014079621;8833.33749968742;8844.73465796027;8866.113388661082;10635.94682026585;10669.146468282674;10691.518881650189;10770.353778773298;10794.298370605886;9181.54092295396;9216.723498295061;9249.537523123952;9259.212966897889;9328.626854925998;8909.465432074096;8981.326400520118;9008.963969143633;9017.594208260512;9025.277977761894;7983;8052.194780522135;8143.8778418324955;8147.674093036212;8167.714130005421;5935.614185077956;5957.927573036895;6031.638101713911;6096.603720758137;6139.84650383744;6063.363346848518;6144.969275153596;6211.316755156839;6213.751449941951;6367.522435817425 09:43:46 INFO - PID 1642 | |4;prototype.html;404.37725902110753;408.25289719812736;410.87879075672674;416.869795345783;422.01670108646834;4676;5133.82031628893;5277.3139491866;5712.285964254468;6194.566380353377;5743.913841292384;5799.82600521985;5883.85290367741;5937.109433584965;5983.88032239356;3666.926661466769;3865.6520913117815;4460.197164510387;4471.083427897273;4521;4352.12957408518;4490.383461953694;4541.159885421192;4553.817847286105;4561.589456948874;3811.9889405259046;3855.4024126260474;4362.6727995400315;4418.293073108303;4452.287633978564;3626.510421093145;4447.710898791568;4450.977745111286;4458.643308535326;4472.932906006413;3969.2656858481273;3987.920241595181;3991.3214753491975;3996.460477835484;4030.2745505808944;4770.475247722748;5179.948200517984;5777.913331300034;5781.364049954502;5822.359540450547;5381.892362152735;5406.972965135188;5412.188171774226;5422.078246698071;5432.261676263597;5273.815416460406;6451.096846441502;6459.773907913247;6476.579022363531;6513.316101809289;4048.6153815387784;4203.957960420387;4264.296391095466;4271.337942618899;4294.656427485794;6620.834479138012;6785.72857085716;6864.107666003388;6881.933300338405;6884.827879303008;4343.326784348431;4367.5414081520985;4376.846810361622;4383.846565370197;4391.538888416734;4421.867343979686;4455.487618923865;4470.754108524063;4471.227838740002;4475.351074094238;4976.328195693607;5221.016013914688;5234.953009398136;5244.423113457517;5260.342457192851;5414.15594927598;5947.702614869326;6534.379233972765;6549.574277671936;6570.474362051024;1318.971202462062;1512.7730840373813;1533.5552689719857;1537.3005282596391;1538.8384219656998;940;995.3430735714394;1000.9649662261786;1003.8845532763826;1014.1481155829139;6159.599626024294;6187.412195841388;6204.286507051746;6212.489943182178;6251.249850018027;5671.829845104571;6715.865682686319;6744.976507047866;6783.796486105425;6793.694283757242;4744.5492678195515;5629.690367029771;6134.539909506716;6150.384961503813;6155.261368635703;3011.4101872390165;3084.1826915867314;3094.6441159266524;3540.7698499597445;3546.91132721684;6726.932730672728;6848.7260509579055;6860.794176174722;6934.375906168469;6949.89575156373;5502.899420115993;6760.83097922546;6955.89566156508;6956.373926346653;6979.825504362431;6688.832779180462;6866.896996545156;6871.415929645936;6941.68762405693;6962.651867406609;6162.291336496181;6382.936170638234;6748.447856992821;6760.580278141645;6783.152105986752;5441.619086664054;5510.669359838423;6644.202695676549;6670.39966403026;6672.366125218096;6913.446924245947;6915.446764258747;6984.720611175496;6986.231514533296;7008.229094799466;4398.47218333802;4398.626116780109;4404.8458303959205;4406.889827754332;4408.404865343137;5940.574262177132;6498.577592456475;6737.69680364375;6742.190937087581;6762.96618516924;6429.807105786834;6517.989711594711;6534.901976470262;6535.477161826947;6587;6311.211098612674;6464.644444555594;6508.316626754123;6515.934840651723;6534.901976470262;6336.441782754827;6350.269718982377;6350.618962862243;6363.3636636336;6369.777057802955;5051.772670229775;6536.379043990813;6556.803820389686;6571.901421478586;6586.80239592813;5211.661242019257;6235.376462353728;6254.874902502015;6327.746890124344;6335.4931605472375 09:43:46 INFO - PID 1642 | |5;yui.html;835.7283882738112;848.6478111583693;867.6963062927975;876.4828751036891;882.4661080046571;14262.71474570508;14415.711685766279;14767;16302.918485407572;16443.095629740375;13119.934400327986;13172.670683232924;17206.913965430187;17218.053007084607;17220.82779172208;974.2400927276718;992.1913640383065;1019.648221363632;1020.6172685243034;1022.8874823769379;1008.0322890025584;1014.5941623350645;1027.2193133218732;1029.2486484866051;1029.5881647341087;1025.912797412221;1064.5156453813536;1064.8296272596385;1076.34343050739;1088.6298658456124;1040.1159014837403;1050.2070936442974;1057.5558265528457;1062.4315990944808;1067.3329169269207;790.1545346479212;796.9203079692043;798.5129071266523;799.7800604833659;800.8398320335956;16508.42220522276;16803.747943780854;16971.830281697148;17191.570210744707;17440.825591744175;16923;16996.235169417407;17137.400190993256;17350.913245433818;17360.826391736173;13837.515686950908;13956.162630242217;14058.85941140596;14068.718625627533;14149.363278652485;3490.5287786148797;3512.121969507623;3513.472979053137;3516.806575638339;3521.630228825962;98764;125270;126013;127688;128167.35916320451;13198.934005330104;13209.933950330187;13379.397927093305;13432.664183395493;13481.325933703276;25129.497410051696;25357.87321063383;25796.74203257981;25888;26093;8736.475811451206;8737.956310218535;8809.603567839462;8822.558872056372;8842.248408885316;4711.929321060187;4797.4482934462285;4835.734034628129;4836.879078023007;4838.854834354975;4273.294906340481;4387.758673273001;4404.55954404557;4617.699849509839;4621.1746360187535;959.4195511715451;977.6236149082655;998.7053819123377;1000.4147573669485;1001.5543083327849;652.47475781995;659.5844617890698;667.1360588038502;668.0880597983814;682.8839097353462;10788.784224315626;11072.833907491395;11793;11913.940430297793;11939.76120477603;649.4090377756313;658.8616390557941;664.9069130321759;667.8163505036057;677.3294438505942;4404.185225733249;4616.930746038812;4715.929261061086;5082.339295891585;5408.350997880201;89170.21659566772;91904.54047729718;93560.53219733857;95309.04690953002;96495;85313.14686853177;86136.56931715301;86878.56560717283;86927;89074.66388004055;78633.60683196547;79061.6820189032;80751.59624201841;80882.59558702169;81150.59424702839;11073.062214112337;11587.130965177814;12221.938890305491;12253.081018923795;12298.446569904198;38865;39629.00927476836;39638;39642.207155856144;39691.60308396879;50697;51062.489375105775;51305.743471283895;51345.486545134074;52243.47756522386;15752.60618484547;15856.28312940873;15901.840981590036;16012;16076.19619019021;14767.187804670846;17735.871695396636;17856.107194640477;17918.193681284112;17935.282588696307;16008.03951762898;16101;16441.753373699645;16458;16508.504744857673;15962.361505540113;16101.516954491384;16226.026438413734;16240.02559846413;16291;13967.371468284155;16178.433754818525;16406.83593164053;16613.50159495217;16745.497635070966;11391.316521008766;11833.704157396134;12048.518059277882;12255.632331030083;12448.190867593577;12735.426905789076;12922.870771292166;12967.351632418153;12992.220466772023;13268.867311327149 09:43:46 INFO - PID 1642 | __end_tp_report 09:43:46 INFO - PID 1642 | __start_cc_report 09:43:46 INFO - PID 1642 | _x_x_mozilla_cycle_collect,406 09:43:46 INFO - PID 1642 | __end_cc_report 09:43:46 INFO - PID 1642 | __startTimestamp1491842626423__endTimestamp 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | ------- Summary: start ------- 09:43:46 INFO - PID 1642 | Number of tests: 6 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6069.80 Median:6348.78 stddev:712.56 (11.2%) stddev-sans-first:685.15 09:43:46 INFO - PID 1642 | Values: 3478.8 3536.1 3585.0 3597.9 3604.2 6059.6 6137.8 6145.2 6192.3 6221.9 6077.8 6102.6 6107.4 6119.0 6234.3 5305.9 5418.8 5424.1 5483.8 5498.1 5377.5 5433.9 5505.7 5533.4 5549.6 5477.5 5495.9 5502.5 5510.8 5520.8 5278.5 5334.6 5345.8 5378.4 5449.8 4437.3 5315.5 5317.6 5362.6 5410.9 5041.3 5904.2 6084.5 6216.0 6238.1 6358.8 6401.5 6541.7 6576.4 6590.6 5407.8 6660.7 6726.1 6740.8 6790.7 4821.8 6286.9 6329.9 6348.6 6349.2 6485.7 6674.1 6740.9 6873.9 6919.4 6314.0 6401.6 6449.8 6501.6 6503.3 6438.6 6463.5 6610.0 6670.4 6695.3 5407.3 6537.8 6574.5 6580.9 6616.4 6241.4 6399.2 6571.7 6580.1 6589.3 5232.3 5305.4 5328.6 5378.8 5394.1 4705.4 4712.5 4716.1 4717.1 4760.6 6134.5 6348.2 6359.5 6366.3 6380.7 6393.9 6412.6 6596.3 6611.2 6658.8 6319.3 6353.5 6355.0 6367.3 6382.6 5737.0 5838.7 5848.4 5879.4 5936.9 5660.6 6019.7 6502.3 6747.6 6785.8 6703.0 6721.9 6724.8 6729.8 6741.9 6828.9 6860.7 6866.3 6906.5 6912.2 6251.7 6356.4 6413.5 6518.5 6636.2 6468.8 6679.7 6687.8 6690.0 6706.3 6442.0 6454.7 6471.4 6483.2 6484.6 6215.6 6334.4 6396.1 6481.4 6502.2 6223.2 6240.4 6369.1 6375.4 6389.6 6496.1 6505.9 6509.5 6526.6 6541.4 6183.6 6212.8 6269.3 6281.5 6348.8 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:44234.28 Median:187431.25 stddev:77204.57 (41.2%) stddev-sans-first:77351.88 09:43:46 INFO - PID 1642 | Values: 676.9 799.3 833.0 1271.3 1289.2 37040.9 38012.4 38024.4 38090.0 39025.6 37863.6 37930.8 38200.8 38265.4 38289.4 8029.2 8491.9 8687.6 8708.6 8746.6 7513.5 8658.4 8791.2 8797.0 8799.5 8717.7 8759.6 8821.5 8825.8 8839.1 8747.9 8781.7 8782.1 8783.2 8819.0 8418.0 8486.9 8498.5 8519.2 8550.3 36856.0 36911.6 36915.0 36978.4 37015.8 3594.3 3596.0 3645.9 3647.1 3652.0 30329.0 30445.2 30495.5 30526.8 30597.5 3132.7 3161.8 3163.3 3166.6 3179.9 221429.0 222655.0 248171.0 263382.0 264034.0 47580.8 47584.3 47667.0 47685.5 47849.8 49401.8 49498.8 49557.8 49590.8 49598.8 14101.6 14208.6 14249.6 14271.9 14283.7 11606.8 11663.9 11765.2 11789.2 11814.4 13440.3 13449.9 13462.3 13472.9 13539.7 5295.1 5394.5 5610.6 5936.7 5966.1 940.7 965.5 1037.2 1066.5 1069.4 21326.6 21764.7 23582.2 24763.9 24929.1 988.0 1058.5 1104.7 1155.1 1157.0 10741.9 12507.9 12530.4 12559.2 12684.0 334015.0 336546.0 336698.0 340993.0 341104.0 41798.4 53443.5 53817.0 53888.5 54016.0 1455.3 1513.2 1528.3 1537.0 1539.2 23720.6 23982.8 24013.8 24105.9 24153.4 31412.4 37972.8 37982.8 38060.2 38070.0 291432.0 291787.0 292374.0 294349.5 294655.0 31367.8 33485.7 33869.5 34618.7 34653.5 44529.0 45289.5 45473.8 45541.5 45606.1 29992.9 30720.8 30889.5 31217.2 31401.7 27772.0 28341.6 30398.2 30913.8 31144.2 36050.6 36761.6 37213.1 37286.0 37341.7 26278.3 29561.7 31528.5 32037.8 32116.7 20061.6 22585.5 23644.4 24527.5 24844.6 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:40472.84 Median:12321.74 stddev:115137.58 (934.4%) stddev-sans-first:115421.32 09:43:46 INFO - PID 1642 | Values: 431.9 432.6 436.7 440.1 461.3 19805.3 21450.9 21884.0 22046.9 22222.9 18548.5 21987.5 22400.4 22950.4 23430.2 6136.1 6370.4 6371.2 6377.2 6384.5 5990.3 6249.2 6274.9 6294.2 6296.4 6189.1 6189.1 6235.0 6240.2 6258.0 6096.2 6197.7 6225.8 6234.3 6254.2 5430.9 5541.6 5542.1 5564.6 5567.9 26895.5 27293.7 27546.3 27547.0 27902.7 2166.8 2224.8 2229.4 2243.8 2246.1 17711.0 17716.4 17753.1 18257.3 18357.4 2183.1 2185.8 2243.0 2245.1 2245.2 135138.0 144675.0 154777.1 155082.0 156961.4 10632.4 11850.9 12316.4 12888.4 13009.3 16275.6 16540.5 16611.6 16619.3 16642.9 7606.0 8767.3 9052.9 9077.4 9126.1 8484.3 8572.9 8629.0 8783.4 8785.8 7804.1 7936.1 7996.2 8005.2 8021.2 1846.4 2050.9 2179.3 2190.5 2195.0 964.9 970.9 975.2 975.7 989.9 20741.6 20765.6 20875.4 21448.9 27017.7 836.9 1023.3 1025.9 1047.9 1055.8 10818.0 10979.7 11109.5 11114.3 11190.7 666701.0 667569.0 690475.0 693728.0 703548.0 157631.8 159755.0 163038.0 164406.0 169550.0 1228.2 1237.6 1258.2 1260.1 1263.1 18326.5 18354.9 18358.0 18398.8 18630.0 46228.0 48677.8 54578.7 66762.0 69419.0 84386.6 89138.0 89353.0 89599.6 92657.0 8690.7 8822.0 8836.6 9180.5 9370.6 12655.2 13495.5 14355.5 14528.7 14655.2 10488.4 12223.7 12242.6 12368.9 12389.4 10203.5 11303.9 11590.8 11618.0 11850.7 11316.5 11647.0 12036.0 12084.6 12086.7 8878.4 8951.7 9026.7 9054.2 9364.9 11964.5 12007.4 12169.2 12212.3 12231.6 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7111.77 Median:2524.32 stddev:4468.43 (177.0%) stddev-sans-first:4459.38 09:43:46 INFO - PID 1642 | Values: 1267.3 1364.4 1417.8 1425.1 1437.7 9412.8 11600.3 11679.2 11840.1 12011.0 11178.0 11245.9 11363.7 11367.3 11399.1 2469.3 2520.2 2520.8 2520.8 2527.8 2264.8 2371.7 2431.9 2453.0 2467.3 2443.1 2467.1 2467.3 2493.6 2496.6 2206.4 2272.9 2274.0 2368.5 2439.9 2275.4 2369.2 2444.6 2461.3 2470.9 11510.0 11554.3 11557.0 11563.8 11565.8 6538.5 6791.9 6796.2 6808.0 6808.9 3684.5 4079.9 4275.5 4339.4 4463.5 1236.5 1244.3 1271.8 1281.4 1284.1 12809.0 16070.2 16222.9 16330.8 16356.9 4353.5 5433.7 5517.4 5762.3 5941.1 11385.0 12081.8 12201.8 12260.4 12265.8 6541.8 6602.6 6604.3 6609.5 6617.5 5420.2 6067.5 6124.2 6241.5 6255.4 4316.0 4417.6 4508.1 4539.9 4551.7 1091.4 1315.0 1323.8 1331.6 1332.8 772.3 775.9 796.9 798.1 807.9 6563.5 6966.5 6980.3 7151.5 7287.8 869.6 891.6 897.7 918.2 928.3 3709.5 4097.5 4207.2 4267.4 4364.0 14606.6 15066.0 15189.3 15202.6 15220.2 14666.4 15028.0 15070.6 15081.0 15092.7 9278.5 9749.5 10484.7 10848.7 11023.6 6264.2 7030.5 7160.9 7187.6 7214.5 12837.3 12837.9 12861.5 13260.1 13446.5 13529.7 13670.0 13813.9 13833.5 13958.4 7843.4 8799.6 8833.3 8844.7 8866.1 10635.9 10669.1 10691.5 10770.4 10794.3 9181.5 9216.7 9249.5 9259.2 9328.6 8909.5 8981.3 9009.0 9017.6 9025.3 7983.0 8052.2 8143.9 8147.7 8167.7 5935.6 5957.9 6031.6 6096.6 6139.8 6063.4 6145.0 6211.3 6213.8 6367.5 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5226.11 Median:5779.64 stddev:1665.60 (28.8%) stddev-sans-first:1630.48 09:43:46 INFO - PID 1642 | Values: 404.4 408.3 410.9 416.9 422.0 4676.0 5133.8 5277.3 5712.3 6194.6 5743.9 5799.8 5883.9 5937.1 5983.9 3666.9 3865.7 4460.2 4471.1 4521.0 4352.1 4490.4 4541.2 4553.8 4561.6 3812.0 3855.4 4362.7 4418.3 4452.3 3626.5 4447.7 4451.0 4458.6 4472.9 3969.3 3987.9 3991.3 3996.5 4030.3 4770.5 5179.9 5777.9 5781.4 5822.4 5381.9 5407.0 5412.2 5422.1 5432.3 5273.8 6451.1 6459.8 6476.6 6513.3 4048.6 4204.0 4264.3 4271.3 4294.7 6620.8 6785.7 6864.1 6881.9 6884.8 4343.3 4367.5 4376.8 4383.8 4391.5 4421.9 4455.5 4470.8 4471.2 4475.4 4976.3 5221.0 5235.0 5244.4 5260.3 5414.2 5947.7 6534.4 6549.6 6570.5 1319.0 1512.8 1533.6 1537.3 1538.8 940.0 995.3 1001.0 1003.9 1014.1 6159.6 6187.4 6204.3 6212.5 6251.2 5671.8 6715.9 6745.0 6783.8 6793.7 4744.5 5629.7 6134.5 6150.4 6155.3 3011.4 3084.2 3094.6 3540.8 3546.9 6726.9 6848.7 6860.8 6934.4 6949.9 5502.9 6760.8 6955.9 6956.4 6979.8 6688.8 6866.9 6871.4 6941.7 6962.7 6162.3 6382.9 6748.4 6760.6 6783.2 5441.6 5510.7 6644.2 6670.4 6672.4 6913.4 6915.4 6984.7 6986.2 7008.2 4398.5 4398.6 4404.8 4406.9 4408.4 5940.6 6498.6 6737.7 6742.2 6763.0 6429.8 6518.0 6534.9 6535.5 6587.0 6311.2 6464.6 6508.3 6515.9 6534.9 6336.4 6350.3 6350.6 6363.4 6369.8 5051.8 6536.4 6556.8 6571.9 6586.8 5211.7 6235.4 6254.9 6327.7 6335.5 09:43:46 INFO - PID 1642 | 09:43:46 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:20964.82 Median:17219.44 stddev:28966.43 (168.2%) stddev-sans-first:29008.26 09:43:46 INFO - PID 1642 | Values: 835.7 848.6 867.7 876.5 882.5 14262.7 14415.7 14767.0 16302.9 16443.1 13119.9 13172.7 17206.9 17218.1 17220.8 974.2 992.2 1019.6 1020.6 1022.9 1008.0 1014.6 1027.2 1029.2 1029.6 1025.9 1064.5 1064.8 1076.3 1088.6 1040.1 1050.2 1057.6 1062.4 1067.3 790.2 796.9 798.5 799.8 800.8 16508.4 16803.7 16971.8 17191.6 17440.8 16923.0 16996.2 17137.4 17350.9 17360.8 13837.5 13956.2 14058.9 14068.7 14149.4 3490.5 3512.1 3513.5 3516.8 3521.6 98764.0 125270.0 126013.0 127688.0 128167.4 13198.9 13209.9 13379.4 13432.7 13481.3 25129.5 25357.9 25796.7 25888.0 26093.0 8736.5 8738.0 8809.6 8822.6 8842.2 4711.9 4797.4 4835.7 4836.9 4838.9 4273.3 4387.8 4404.6 4617.7 4621.2 959.4 977.6 998.7 1000.4 1001.6 652.5 659.6 667.1 668.1 682.9 10788.8 11072.8 11793.0 11913.9 11939.8 649.4 658.9 664.9 667.8 677.3 4404.2 4616.9 4715.9 5082.3 5408.4 89170.2 91904.5 93560.5 95309.0 96495.0 85313.1 86136.6 86878.6 86927.0 89074.7 78633.6 79061.7 80751.6 80882.6 81150.6 11073.1 11587.1 12221.9 12253.1 12298.4 38865.0 39629.0 39638.0 39642.2 39691.6 50697.0 51062.5 51305.7 51345.5 52243.5 15752.6 15856.3 15901.8 16012.0 16076.2 14767.2 17735.9 17856.1 17918.2 17935.3 16008.0 16101.0 16441.8 16458.0 16508.5 15962.4 16101.5 16226.0 16240.0 16291.0 13967.4 16178.4 16406.8 16613.5 16745.5 11391.3 11833.7 12048.5 12255.6 12448.2 12735.4 12922.9 12967.4 12992.2 13268.9 09:43:46 INFO - PID 1642 | -------- Summary: end -------- 09:43:46 INFO - PID 1642 | 09:43:47 INFO - TEST-INFO | 1642: exit 0 09:43:47 INFO - TEST-OK | dromaeo_css | took 1115399ms 09:43:47 INFO - TEST-START | kraken 09:43:47 INFO - operating with platform_type : mac_ 09:43:47 INFO - Initialising browser for kraken test... 09:43:47 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpEO1zA1/profile http://localhost:49238/getInfo.html) 09:43:49 INFO - PID 1654 | 2017-04-10 09:43:49.990 plugin-container[1655:10108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 09:43:49 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:50 INFO - PID 1654 | 2017-04-10 09:43:49.996 plugin-container[1655:10108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c2b, name = 'com.apple.CFPasteboardClient' 09:43:50 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:50 INFO - PID 1654 | 2017-04-10 09:43:49.996 plugin-container[1655:10108] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:43:50 INFO - PID 1654 | __metrics Screen width/height:1600/1200 09:43:50 INFO - PID 1654 | colorDepth:24 09:43:50 INFO - PID 1654 | Browser inner width/height: 1024/689 09:43:50 INFO - PID 1654 | __metrics 09:43:50 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:43:51 INFO - TEST-INFO | 1654: exit 0 09:43:51 INFO - Browser initialized. 09:43:51 INFO - Running cycle 1/1 for kraken test... 09:43:51 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpEO1zA1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:53 INFO - PID 1656 | 2017-04-10 09:43:53.759 plugin-container[1657:10232] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:43:53 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:53 INFO - PID 1656 | 2017-04-10 09:43:53.760 plugin-container[1657:10232] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e13, name = 'com.apple.CFPasteboardClient' 09:43:53 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:53 INFO - PID 1656 | 2017-04-10 09:43:53.760 plugin-container[1657:10232] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:44:03 INFO - PID 1656 | RSS: Main: 233668608 09:44:03 INFO - PID 1656 | 09:44:06 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:07 INFO - PID 1656 | RSS: Main: 248889344 09:44:07 INFO - PID 1656 | 09:44:10 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 09:44:10 INFO - PID 1656 | RSS: Main: 257581056 09:44:10 INFO - PID 1656 | 09:44:14 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 09:44:14 INFO - PID 1656 | RSS: Main: 259870720 09:44:14 INFO - PID 1656 | 09:44:17 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 09:44:17 INFO - PID 1656 | RSS: Main: 261758976 09:44:17 INFO - PID 1656 | 09:44:19 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:20 INFO - PID 1656 | RSS: Main: 261984256 09:44:20 INFO - PID 1656 | 09:44:23 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:23 INFO - PID 1656 | RSS: Main: 267354112 09:44:23 INFO - PID 1656 | 09:44:27 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:27 INFO - PID 1656 | RSS: Main: 268365824 09:44:27 INFO - PID 1656 | 09:44:31 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 09:44:31 INFO - PID 1656 | RSS: Main: 265224192 09:44:31 INFO - PID 1656 | 09:44:33 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:34 INFO - PID 1656 | RSS: Main: 266518528 09:44:34 INFO - PID 1656 | 09:44:36 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:36 INFO - PID 1656 | RSS: Main: 267157504 09:44:36 INFO - PID 1656 | 09:44:39 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:39 INFO - PID 1656 | RSS: Main: 267472896 09:44:39 INFO - PID 1656 | 09:44:42 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:43 INFO - PID 1656 | RSS: Main: 267755520 09:44:43 INFO - PID 1656 | 09:44:46 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:47 INFO - PID 1656 | RSS: Main: 267546624 09:44:47 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 09:44:49 INFO - PID 1656 | RSS: Main: 270573568 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | __start_tp_report 09:44:49 INFO - PID 1656 | _x_x_mozilla_page_load 09:44:49 INFO - PID 1656 | _x_x_mozilla_page_load_details 09:44:49 INFO - PID 1656 | |i|pagename|runs| 09:44:49 INFO - PID 1656 | |0;ai-astar;107;123;151;184;113;182;184;167;123;143 09:44:49 INFO - PID 1656 | |1;audio-beat-detection;149;115;131;161;129;116;117;116;140;117 09:44:49 INFO - PID 1656 | |2;audio-dft;222;227;219;238;214;215;223;211;203;211 09:44:49 INFO - PID 1656 | |3;audio-fft;84;61;58;97;87;51;92;92;101;63 09:44:49 INFO - PID 1656 | |4;audio-oscillator;88;72;91;76;75;74;87;72;71;89 09:44:49 INFO - PID 1656 | |5;imaging-gaussian-blur;90;91;93;96;90;99;93;90;91;93 09:44:49 INFO - PID 1656 | |6;imaging-darkroom;100;99;105;107;160;100;154;130;98;98 09:44:49 INFO - PID 1656 | |7;imaging-desaturate;100;104;120;88;160;154;154;148;157;99 09:44:49 INFO - PID 1656 | |8;json-parse-financial;52;53;51;51;53;52;53;52;54;51 09:44:49 INFO - PID 1656 | |9;json-stringify-tinderbox;61;60;79;99;63;97;92;65;52;90 09:44:49 INFO - PID 1656 | |10;stanford-crypto-aes;87;85;111;79;115;79;99;117;112;112 09:44:49 INFO - PID 1656 | |11;stanford-crypto-ccm;150;150;147;146;149;182;175;151;230;137 09:44:49 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;230;203;197;197;194;199;192;196;192;199 09:44:49 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;95;60;65;77;71;97;103;97;81;72 09:44:49 INFO - PID 1656 | __end_tp_report 09:44:49 INFO - PID 1656 | __start_cc_report 09:44:49 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1005 09:44:49 INFO - PID 1656 | __end_cc_report 09:44:49 INFO - PID 1656 | __startTimestamp1491842689754__endTimestamp 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | ------- Summary: start ------- 09:44:49 INFO - PID 1656 | Number of tests: 14 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:147.70 Median:159.00 stddev:30.36 (19.1%) stddev-sans-first:28.41 09:44:49 INFO - PID 1656 | Values: 107.0 123.0 151.0 184.0 113.0 182.0 184.0 167.0 123.0 143.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:130.00 stddev:16.23 (12.5%) stddev-sans-first:15.54 09:44:49 INFO - PID 1656 | Values: 149.0 115.0 131.0 161.0 129.0 116.0 117.0 116.0 140.0 117.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:218.30 Median:220.50 stddev:9.83 (4.5%) stddev-sans-first:10.34 09:44:49 INFO - PID 1656 | Values: 222.0 227.0 219.0 238.0 214.0 215.0 223.0 211.0 203.0 211.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:78.60 Median:85.50 stddev:18.37 (21.5%) stddev-sans-first:19.38 09:44:49 INFO - PID 1656 | Values: 84.0 61.0 58.0 97.0 87.0 51.0 92.0 92.0 101.0 63.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:81.50 stddev:8.15 (10.0%) stddev-sans-first:8.05 09:44:49 INFO - PID 1656 | Values: 88.0 72.0 91.0 76.0 75.0 74.0 87.0 72.0 71.0 89.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:92.60 Median:93.00 stddev:2.95 (3.2%) stddev-sans-first:2.98 09:44:49 INFO - PID 1656 | Values: 90.0 91.0 93.0 96.0 90.0 99.0 93.0 90.0 91.0 93.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:115.10 Median:157.00 stddev:24.08 (15.3%) stddev-sans-first:24.91 09:44:49 INFO - PID 1656 | Values: 100.0 99.0 105.0 107.0 160.0 100.0 154.0 130.0 98.0 98.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:128.40 Median:155.50 stddev:28.83 (18.5%) stddev-sans-first:28.69 09:44:49 INFO - PID 1656 | Values: 100.0 104.0 120.0 88.0 160.0 154.0 154.0 148.0 157.0 99.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.03 (2.0%) stddev-sans-first:1.09 09:44:49 INFO - PID 1656 | Values: 52.0 53.0 51.0 51.0 53.0 52.0 53.0 52.0 54.0 51.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:84.50 stddev:17.57 (20.8%) stddev-sans-first:17.80 09:44:49 INFO - PID 1656 | Values: 61.0 60.0 79.0 99.0 63.0 97.0 92.0 65.0 52.0 90.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:99.60 Median:79.00 stddev:15.63 (19.8%) stddev-sans-first:15.90 09:44:49 INFO - PID 1656 | Values: 87.0 85.0 111.0 79.0 115.0 79.0 99.0 117.0 112.0 112.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:161.70 Median:150.50 stddev:27.64 (18.4%) stddev-sans-first:28.99 09:44:49 INFO - PID 1656 | Values: 150.0 150.0 147.0 146.0 149.0 182.0 175.0 151.0 230.0 137.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.90 Median:198.00 stddev:11.10 (5.6%) stddev-sans-first:3.57 09:44:49 INFO - PID 1656 | Values: 230.0 203.0 197.0 197.0 194.0 199.0 192.0 196.0 192.0 199.0 09:44:49 INFO - PID 1656 | 09:44:49 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.80 Median:79.00 stddev:15.20 (19.2%) stddev-sans-first:15.35 09:44:49 INFO - PID 1656 | Values: 95.0 60.0 65.0 77.0 71.0 97.0 103.0 97.0 81.0 72.0 09:44:49 INFO - PID 1656 | -------- Summary: end -------- 09:44:49 INFO - PID 1656 | 09:44:50 INFO - TEST-INFO | 1656: exit 0 09:44:50 INFO - TEST-OK | kraken | took 63715ms 09:44:50 INFO - SUITE-END | took 1179s 09:44:50 INFO - Completed test suite (00:19:39) 09:44:50 INFO - javascript benchmark 09:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7866.708024827471, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3478.808665523396, 3536.0982949347926, 3585.049961760132, 3597.9280414391715, 3604.2250916053054, 6059.606125601844, 6137.846553836151, 6145.231846019247, 6192.287886893008, 6221.875562488747, 6077.78727744529, 6102.64073755963, 6107.4197951194565, 6119.0, 6234.345393733661, 5305.912287980955, 5418.810341638044, 5424.0779067558515, 5483.75323110461, 5498.147787093007, 5377.46225377463, 5433.891322173554, 5505.697186654733, 5533.391326954052, 5549.5837812164045, 5477.534409575191, 5495.917561236584, 5502.504774570288, 5510.752016159283, 5520.779168833242, 5278.498542638443, 5334.626576139672, 5345.812896548602, 5378.381486129067, 5449.809256675997, 4437.334399840018, 5315.468453154654, 5317.627766056377, 5362.624616276862, 5410.945890541084, 5041.269015992661, 5904.2029326040865, 6084.482818960394, 6216.005439129717, 6238.1266622672865, 6358.809235722936, 6401.519886008568, 6541.672916354163, 6576.4410025147445, 6590.637514936677, 5407.783248769035, 6660.666966651648, 6726.058351830748, 6740.797776066725, 6790.728370865159, 4821.7589120543835, 6286.9056964145575, 6329.905051424278, 6348.587341822767, 6349.206349206349, 6485.675716214265, 6674.098996635489, 6740.898886516707, 6873.896891546631, 6919.37725604698, 6314.0, 6401.58389704677, 6449.774257900951, 6501.577397469149, 6503.349665033459, 6438.581492202992, 6463.515236357292, 6610.041543976096, 6670.433013193836, 6695.263521012685, 5407.297051383295, 6537.803865884031, 6574.5397822152945, 6580.901286480706, 6616.404523592803, 6241.438270555672, 6399.200099987502, 6571.704273307712, 6580.078788969548, 6589.275179730226, 5232.319798426181, 5305.44292849253, 5328.626996110235, 5378.757955891994, 5394.056040192951, 4705.435347758223, 4712.458067322234, 4716.127516409475, 4717.127331443694, 4760.619150467955, 6134.539909506805, 6348.238211414568, 6359.459445947054, 6366.331535188739, 6380.7447702091395, 6393.904091438632, 6412.64730439821, 6596.340365963461, 6611.173603299588, 6658.83352916181, 6319.304876463585, 6353.491720662336, 6354.968225158845, 6367.267764207176, 6382.648954307465, 5736.996025695486, 5838.7080645967535, 5848.4151584841175, 5879.412058794172, 5936.881262374728, 5660.603757736919, 6019.70576326092, 6502.349765023459, 6747.595144291358, 6785.796426107225, 6703.0, 6721.899171512529, 6724.7982560521305, 6729.798106056826, 6741.865162696817, 6828.863422731617, 6860.725570977105, 6866.313368663094, 6906.482013848881, 6912.239653638197, 6251.718672659832, 6356.4279214870885, 6413.486921046212, 6518.511111666549, 6636.170478690164, 6468.8059358219325, 6679.6994135265, 6687.832804179934, 6689.966550167413, 6706.262311145672, 6442.0, 6454.677266136769, 6471.385218404433, 6483.157189565326, 6484.643344615903, 6215.564910456405, 6334.398232167937, 6396.10454536356, 6481.4166724994975, 6502.187226596676, 6223.222097237845, 6240.438360547572, 6369.108324834434, 6375.362463753588, 6389.616623002449, 6496.090547323284, 6505.902411463737, 6509.4792416605615, 6526.608403495806, 6541.443977261986, 6183.5671502994355, 6212.782552610818, 6269.341719119427, 6281.528885333527, 6348.77779277723], "value": 6024.99282269331, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.9086173366594, 799.3445374792668, 832.9708460203894, 1271.294431590468, 1289.1620446709637, 37040.888773336774, 38012.42981355282, 38024.42963355552, 38090.0, 39025.60974390252, 37863.621363786355, 37930.81034594823, 38200.752936000405, 38265.426018609745, 38289.42565861507, 8029.197080291968, 8491.872621910676, 8687.609057592392, 8708.564571771418, 8746.606402711894, 7513.474056816025, 8658.393912426132, 8791.164839340252, 8797.032326444087, 8799.516026618534, 8717.694880679177, 8759.562021898912, 8821.470711757314, 8825.823483530325, 8839.07189745077, 8747.912520874774, 8781.692640757576, 8782.12178782123, 8783.165599268123, 8819.029906710224, 8418.0, 8486.872696909551, 8498.532580708059, 8519.190676885686, 8550.315974722007, 36856.0, 36911.63088369109, 36915.0, 36978.44532332017, 37015.81492092522, 3594.263176048904, 3595.9640403596154, 3645.8906232813056, 3647.0882279430143, 3652.0, 30329.0, 30445.23886902823, 30495.542566861513, 30526.84736576325, 30597.541036884464, 3132.6554079051284, 3161.8260995645232, 3163.2566346908457, 3166.62000559932, 3179.9046028619177, 221429.0, 222655.0, 248171.0, 263382.0, 264034.0, 47580.7620961893, 47584.286235706495, 47667.0, 47685.52314476811, 47849.76075119602, 49401.75299123481, 49498.75250623724, 49557.752211238716, 49590.75204624026, 49598.76003099951, 14101.576952691436, 14208.57914208571, 14249.643758905902, 14271.930570067281, 14283.714325713427, 11606.76786464266, 11663.88336116628, 11765.176437649283, 11789.233699809485, 11814.350210738492, 13440.32798360078, 13449.865501345057, 13462.259575723234, 13472.854807341486, 13539.661508462368, 5295.12630415977, 5394.462578165204, 5610.635308704921, 5936.7440372658975, 5966.136254597817, 940.6519587752439, 965.4979410706534, 1037.1702637889657, 1066.5200659703164, 1069.4332004037872, 21326.573468530853, 21764.694118352632, 23582.17462388808, 24763.876180618983, 24929.127480538456, 987.9654212102541, 1058.5448257249457, 1104.6851647280487, 1155.070168514354, 1156.988430115705, 10741.89258107409, 12507.93746031264, 12530.37348132608, 12559.183653062704, 12684.0, 334015.0, 336546.0, 336698.0, 340993.0, 341104.0, 41798.37302440405, 53443.465565344624, 53817.0, 53888.461115388345, 54016.0, 1455.294182321573, 1513.1904431129512, 1528.335174199227, 1536.9923150384177, 1539.1611571693454, 23720.644190336814, 23982.800859957282, 24013.75986240115, 24105.879470602536, 24153.396165096012, 31412.37175256528, 37972.81013594914, 37982.81008594939, 38060.238795223384, 38070.0, 291432.0, 291787.0, 292374.0, 294349.5282523574, 294655.0, 31367.84316078405, 33485.66514334923, 33869.491957620165, 34618.65381346154, 34653.48019779756, 44529.0, 45289.54710452853, 45473.77263113796, 45541.54458455506, 45606.08787824291, 29992.85003574968, 30720.84639576788, 30889.536656950615, 31217.219569510944, 31401.685983139876, 27772.0, 28341.574876377283, 30398.240043999078, 30913.8454307727, 31144.197022268105, 36050.63949360473, 36761.63238367689, 37213.06967325838, 37286.0, 37341.69304074344, 26278.343041424116, 29561.704382955893, 31528.527072094395, 32037.839810800797, 32116.67883321137, 20061.595688301677, 22585.548289034457, 23644.408889777893, 24527.509449810546, 24844.627330589694], "value": 17435.21535946781, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.874756320667, 432.5768222547818, 436.7183166857377, 440.0758407344576, 461.2827053931136, 19805.306814261523, 21450.89274553627, 21884.0, 22046.88976555119, 22222.88888555555, 18548.536286592844, 21987.450313742123, 22400.439989000282, 22950.426239344026, 23430.179943701973, 6136.110264011716, 6370.362963703639, 6371.235451745773, 6377.1825029866495, 6384.5211609129265, 5990.341062483123, 6249.156363890885, 6274.937250627504, 6294.213223347082, 6296.401841825019, 6189.071639254125, 6189.071639254125, 6235.0, 6240.188775459184, 6257.968710156443, 6096.1770161028135, 6197.6901154942525, 6225.8132256032395, 6234.283057448383, 6254.186955695776, 5430.891382172374, 5541.584381171388, 5542.140968149944, 5564.638298510625, 5567.886422715433, 26895.462090758272, 27293.72706272932, 27546.311342216406, 27547.0, 27902.720972790215, 2166.8266538676867, 2224.7663995280586, 2229.3869185973826, 2243.8317126215434, 2246.0791075658904, 17711.0, 17716.379926702502, 17753.11234438273, 18257.269709211614, 18357.449276521726, 2183.0721943174244, 2185.8360622953182, 2243.0467051503047, 2245.0682966568857, 2245.2253972379503, 135138.0, 144675.0, 154777.09866533615, 155082.0, 156961.43038569696, 10632.362058276529, 11850.940745296219, 12316.445759940823, 12888.420021099073, 13009.349532523336, 16275.593110172103, 16540.503784886474, 16611.584710382336, 16619.252133654016, 16642.916785416237, 7606.0, 8767.254783343487, 9052.864207036768, 9077.409968352036, 9126.08739126082, 8484.32125429964, 8572.91427085721, 8628.956855215683, 8783.429077109968, 8785.780355491164, 7804.0635123785505, 7936.127026027132, 7996.24035716606, 8005.199480051948, 8021.197880212048, 1846.3906910719431, 2050.8872012039483, 2179.3244094330807, 2190.5290362571805, 2194.9561008779733, 964.8793900762405, 970.8689376876001, 975.1808480876098, 975.6633961283346, 989.9109080182818, 20741.58516829655, 20765.58468830615, 20875.37373878786, 21448.892755536122, 27017.729822701913, 836.928731224022, 1023.2632504596678, 1025.9384436933808, 1047.9476026198658, 1055.7888422315414, 10818.0, 10979.725506862393, 11109.500072496758, 11114.277571957797, 11190.720231994264, 666701.0, 667569.0, 690475.0, 693728.0, 703548.0, 157631.8473630521, 159755.0, 163038.0, 164406.0, 169550.0, 1228.1832581333313, 1237.6410840856051, 1258.157034786695, 1260.1116213069763, 1263.1473755215377, 18326.450206493828, 18354.90822545879, 18358.0, 18398.816011840245, 18630.0, 46228.0, 48677.75661121672, 54578.72710636421, 66761.99857002246, 69419.0, 84386.57806710927, 89138.0, 89353.0, 89599.55200223956, 92657.0, 8690.652373905226, 8821.955890220508, 8836.646534138563, 9180.54097295146, 9370.625174993196, 12655.240685558896, 13495.460181593018, 14355.497557585435, 14528.709425811636, 14655.193964332064, 10488.39908926507, 12223.69440763988, 12242.632721018384, 12368.876311236772, 12389.442475088823, 10203.540840662337, 11303.886961130283, 11590.826137608112, 11618.0, 11850.703732406759, 11316.547338106713, 11647.0, 12036.037117030792, 12084.637460876187, 12086.697832554257, 8878.422902511316, 8951.73144805657, 9026.729198124067, 9054.185123338932, 9364.906350936404, 11964.46159922823, 12007.399630018639, 12169.20900141488, 12212.267263964191, 12231.571894983634], "value": 10686.582850820208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.2649863079412, 1364.3792074606054, 1417.7944198091277, 1425.1164278147544, 1437.7268319019392, 9412.764680882972, 11600.3039817611, 11679.182457227997, 11840.111991600621, 12011.039116870652, 11178.04986576142, 11245.943770281157, 11363.715907102327, 11367.261128026672, 11399.145064120203, 2469.259222233332, 2520.18094119411, 2520.773130418262, 2520.848749075052, 2527.797776177901, 2264.762199969004, 2371.727251366098, 2431.9392015199674, 2453.0065323543904, 2467.346153269385, 2443.1204766284122, 2467.111839737693, 2467.2721547143547, 2493.551160791057, 2496.6005439129744, 2206.3932418584936, 2272.9090036782354, 2273.965345767672, 2368.455255291293, 2439.878006099688, 2275.419767959176, 2369.2418426103654, 2444.6088625819784, 2461.2739241923496, 2470.9258722238183, 11510.0, 11554.306741595532, 11557.017653499379, 11563.826542601868, 11565.768684626344, 6538.476921846289, 6791.864162716718, 6796.150481189851, 6807.965960170217, 6808.863822723518, 3684.465752465904, 4079.938800917989, 4275.46556680415, 4339.392485052095, 4463.464384273875, 1236.4683186229918, 1244.3467179730624, 1271.790154624486, 1281.423359488234, 1284.1396264502712, 12809.0, 16070.196490175444, 16222.918885405616, 16330.75503867443, 16356.918215408965, 4353.455818022747, 5433.673979561239, 5517.393086760453, 5762.2509073820975, 5941.138534912414, 11385.0, 12081.75836483283, 12201.755964880831, 12260.44827982743, 12265.816012759815, 6541.836454088686, 6602.603843769293, 6604.306547812506, 6609.471242300604, 6617.53677242598, 5420.24116623673, 6067.484263837535, 6124.173236613089, 6241.469475094577, 6255.374462553708, 4315.956840431555, 4417.580329868657, 4508.120916421332, 4539.931901021488, 4551.658625603093, 1091.4215465803138, 1314.9934250328688, 1323.7749582570987, 1331.633800704814, 1332.8134061231435, 772.2624893226955, 775.918528554505, 796.8924195233685, 798.078219656298, 807.9030516338076, 6563.474922006228, 6966.5471744336455, 6980.267071957372, 7151.471237785174, 7287.781366559012, 869.599984007351, 891.5987805487426, 897.6947837735202, 918.196577994255, 928.331601247101, 3709.536307961505, 4097.549269580344, 4207.200631879933, 4267.4025636410925, 4363.978180109143, 14606.634834129232, 15066.0, 15189.316480758393, 15202.619934501727, 15220.238988050553, 14666.413343466354, 15028.0, 15070.623234419008, 15081.0, 15092.698146037237, 9278.536073196448, 9749.463779492196, 10484.685459436228, 10848.67453976382, 11023.61417350389, 6264.21697287839, 7030.483034250424, 7160.928390716234, 7187.604681742554, 7214.494985350975, 12837.29394883253, 12837.87162128404, 12861.549845755353, 13260.138091024053, 13446.529371471952, 13529.729405412034, 13669.97475189345, 13813.861861381258, 13833.515826946008, 13958.37187326593, 7843.372530197685, 8799.648014079621, 8833.33749968742, 8844.73465796027, 8866.113388661082, 10635.94682026585, 10669.146468282674, 10691.518881650189, 10770.353778773298, 10794.298370605886, 9181.54092295396, 9216.723498295061, 9249.537523123952, 9259.212966897889, 9328.626854925998, 8909.465432074096, 8981.326400520118, 9008.963969143633, 9017.594208260512, 9025.277977761894, 7983.0, 8052.194780522135, 8143.8778418324955, 8147.674093036212, 8167.714130005421, 5935.614185077956, 5957.927573036895, 6031.638101713911, 6096.603720758137, 6139.84650383744, 6063.363346848518, 6144.969275153596, 6211.316755156839, 6213.751449941951, 6367.522435817425], "value": 5371.830753935359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.37725902110753, 408.25289719812736, 410.87879075672674, 416.869795345783, 422.01670108646834, 4676.0, 5133.82031628893, 5277.3139491866, 5712.285964254468, 6194.566380353377, 5743.913841292384, 5799.82600521985, 5883.85290367741, 5937.109433584965, 5983.88032239356, 3666.926661466769, 3865.6520913117815, 4460.197164510387, 4471.083427897273, 4521.0, 4352.12957408518, 4490.383461953694, 4541.159885421192, 4553.817847286105, 4561.589456948874, 3811.9889405259046, 3855.4024126260474, 4362.6727995400315, 4418.293073108303, 4452.287633978564, 3626.510421093145, 4447.710898791568, 4450.977745111286, 4458.643308535326, 4472.932906006413, 3969.2656858481273, 3987.920241595181, 3991.3214753491975, 3996.460477835484, 4030.2745505808944, 4770.475247722748, 5179.948200517984, 5777.913331300034, 5781.364049954502, 5822.359540450547, 5381.892362152735, 5406.972965135188, 5412.188171774226, 5422.078246698071, 5432.261676263597, 5273.815416460406, 6451.096846441502, 6459.773907913247, 6476.579022363531, 6513.316101809289, 4048.6153815387784, 4203.957960420387, 4264.296391095466, 4271.337942618899, 4294.656427485794, 6620.834479138012, 6785.72857085716, 6864.107666003388, 6881.933300338405, 6884.827879303008, 4343.326784348431, 4367.5414081520985, 4376.846810361622, 4383.846565370197, 4391.538888416734, 4421.867343979686, 4455.487618923865, 4470.754108524063, 4471.227838740002, 4475.351074094238, 4976.328195693607, 5221.016013914688, 5234.953009398136, 5244.423113457517, 5260.342457192851, 5414.15594927598, 5947.702614869326, 6534.379233972765, 6549.574277671936, 6570.474362051024, 1318.971202462062, 1512.7730840373813, 1533.5552689719857, 1537.3005282596391, 1538.8384219656998, 940.0, 995.3430735714394, 1000.9649662261786, 1003.8845532763826, 1014.1481155829139, 6159.599626024294, 6187.412195841388, 6204.286507051746, 6212.489943182178, 6251.249850018027, 5671.829845104571, 6715.865682686319, 6744.976507047866, 6783.796486105425, 6793.694283757242, 4744.5492678195515, 5629.690367029771, 6134.539909506716, 6150.384961503813, 6155.261368635703, 3011.4101872390165, 3084.1826915867314, 3094.6441159266524, 3540.7698499597445, 3546.91132721684, 6726.932730672728, 6848.7260509579055, 6860.794176174722, 6934.375906168469, 6949.89575156373, 5502.899420115993, 6760.83097922546, 6955.89566156508, 6956.373926346653, 6979.825504362431, 6688.832779180462, 6866.896996545156, 6871.415929645936, 6941.68762405693, 6962.651867406609, 6162.291336496181, 6382.936170638234, 6748.447856992821, 6760.580278141645, 6783.152105986752, 5441.619086664054, 5510.669359838423, 6644.202695676549, 6670.39966403026, 6672.366125218096, 6913.446924245947, 6915.446764258747, 6984.720611175496, 6986.231514533296, 7008.229094799466, 4398.47218333802, 4398.626116780109, 4404.8458303959205, 4406.889827754332, 4408.404865343137, 5940.574262177132, 6498.577592456475, 6737.69680364375, 6742.190937087581, 6762.96618516924, 6429.807105786834, 6517.989711594711, 6534.901976470262, 6535.477161826947, 6587.0, 6311.211098612674, 6464.644444555594, 6508.316626754123, 6515.934840651723, 6534.901976470262, 6336.441782754827, 6350.269718982377, 6350.618962862243, 6363.3636636336, 6369.777057802955, 5051.772670229775, 6536.379043990813, 6556.803820389686, 6571.901421478586, 6586.80239592813, 5211.661242019257, 6235.376462353728, 6254.874902502015, 6327.746890124344, 6335.4931605472375], "value": 4711.6568481620025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.7283882738112, 848.6478111583693, 867.6963062927975, 876.4828751036891, 882.4661080046571, 14262.71474570508, 14415.711685766279, 14767.0, 16302.918485407572, 16443.095629740375, 13119.934400327986, 13172.670683232924, 17206.913965430187, 17218.053007084607, 17220.82779172208, 974.2400927276718, 992.1913640383065, 1019.648221363632, 1020.6172685243034, 1022.8874823769379, 1008.0322890025584, 1014.5941623350645, 1027.2193133218732, 1029.2486484866051, 1029.5881647341087, 1025.912797412221, 1064.5156453813536, 1064.8296272596385, 1076.34343050739, 1088.6298658456124, 1040.1159014837403, 1050.2070936442974, 1057.5558265528457, 1062.4315990944808, 1067.3329169269207, 790.1545346479212, 796.9203079692043, 798.5129071266523, 799.7800604833659, 800.8398320335956, 16508.42220522276, 16803.747943780854, 16971.830281697148, 17191.570210744707, 17440.825591744175, 16923.0, 16996.235169417407, 17137.400190993256, 17350.913245433818, 17360.826391736173, 13837.515686950908, 13956.162630242217, 14058.85941140596, 14068.718625627533, 14149.363278652485, 3490.5287786148797, 3512.121969507623, 3513.472979053137, 3516.806575638339, 3521.630228825962, 98764.0, 125270.0, 126013.0, 127688.0, 128167.35916320451, 13198.934005330104, 13209.933950330187, 13379.397927093305, 13432.664183395493, 13481.325933703276, 25129.497410051696, 25357.87321063383, 25796.74203257981, 25888.0, 26093.0, 8736.475811451206, 8737.956310218535, 8809.603567839462, 8822.558872056372, 8842.248408885316, 4711.929321060187, 4797.4482934462285, 4835.734034628129, 4836.879078023007, 4838.854834354975, 4273.294906340481, 4387.758673273001, 4404.55954404557, 4617.699849509839, 4621.1746360187535, 959.4195511715451, 977.6236149082655, 998.7053819123377, 1000.4147573669485, 1001.5543083327849, 652.47475781995, 659.5844617890698, 667.1360588038502, 668.0880597983814, 682.8839097353462, 10788.784224315626, 11072.833907491395, 11793.0, 11913.940430297793, 11939.76120477603, 649.4090377756313, 658.8616390557941, 664.9069130321759, 667.8163505036057, 677.3294438505942, 4404.185225733249, 4616.930746038812, 4715.929261061086, 5082.339295891585, 5408.350997880201, 89170.21659566772, 91904.54047729718, 93560.53219733857, 95309.04690953002, 96495.0, 85313.14686853177, 86136.56931715301, 86878.56560717283, 86927.0, 89074.66388004055, 78633.60683196547, 79061.6820189032, 80751.59624201841, 80882.59558702169, 81150.59424702839, 11073.062214112337, 11587.130965177814, 12221.938890305491, 12253.081018923795, 12298.446569904198, 38865.0, 39629.00927476836, 39638.0, 39642.207155856144, 39691.60308396879, 50697.0, 51062.489375105775, 51305.743471283895, 51345.486545134074, 52243.47756522386, 15752.60618484547, 15856.28312940873, 15901.840981590036, 16012.0, 16076.19619019021, 14767.187804670846, 17735.871695396636, 17856.107194640477, 17918.193681284112, 17935.282588696307, 16008.03951762898, 16101.0, 16441.753373699645, 16458.0, 16508.504744857673, 15962.361505540113, 16101.516954491384, 16226.026438413734, 16240.02559846413, 16291.0, 13967.371468284155, 16178.433754818525, 16406.83593164053, 16613.50159495217, 16745.497635070966, 11391.316521008766, 11833.704157396134, 12048.518059277882, 12255.632331030083, 12448.190867593577, 12735.426905789076, 12922.870771292166, 12967.351632418153, 12992.220466772023, 13268.867311327149], "value": 8340.806290928496, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1660.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 123.0, 151.0, 184.0, 113.0, 182.0, 184.0, 167.0, 123.0, 143.0], "value": 147.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 131.0, 161.0, 129.0, 116.0, 117.0, 116.0, 140.0, 117.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 227.0, 219.0, 238.0, 214.0, 215.0, 223.0, 211.0, 203.0, 211.0], "value": 218.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 58.0, 97.0, 87.0, 51.0, 92.0, 92.0, 101.0, 63.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 91.0, 76.0, 75.0, 74.0, 87.0, 72.0, 71.0, 89.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 93.0, 96.0, 90.0, 99.0, 93.0, 90.0, 91.0, 93.0], "value": 92.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 99.0, 105.0, 107.0, 160.0, 100.0, 154.0, 130.0, 98.0, 98.0], "value": 115.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 104.0, 120.0, 88.0, 160.0, 154.0, 154.0, 148.0, 157.0, 99.0], "value": 128.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 51.0, 53.0, 52.0, 53.0, 52.0, 54.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 79.0, 99.0, 63.0, 97.0, 92.0, 65.0, 52.0, 90.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 111.0, 79.0, 115.0, 79.0, 99.0, 117.0, 112.0, 112.0], "value": 99.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 147.0, 146.0, 149.0, 182.0, 175.0, 151.0, 230.0, 137.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 203.0, 197.0, 197.0, 194.0, 199.0, 192.0, 196.0, 192.0, 199.0], "value": 199.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 60.0, 65.0, 77.0, 71.0, 97.0, 103.0, 97.0, 81.0, 72.0], "value": 81.8, "unit": "score"}]}]} 09:44:51 INFO - Return code: 0 09:44:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:51 ERROR - # TBPL SUCCESS # 09:44:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:51 INFO - 2017-04-10 09:44:51.107 screenresolution[1661:10631] starting screenresolution argv=screenresolution get 09:44:51 INFO - 2017-04-10 09:44:51.110 screenresolution[1661:10631] Display 0: 1600x1200x32@60 09:44:51 INFO - 2017-04-10 09:44:51.117 screenresolution[1662:10634] starting screenresolution argv=screenresolution list 09:44:51 INFO - Available Modes on Display 0 09:44:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:51 INFO - Intel Iris: 09:44:51 INFO - Chipset Model: Intel Iris 09:44:51 INFO - Type: GPU 09:44:51 INFO - Bus: Built-In 09:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:51 INFO - Vendor: Intel (0x8086) 09:44:51 INFO - Device ID: 0x0a2e 09:44:51 INFO - Revision ID: 0x0009 09:44:51 INFO - Displays: 09:44:51 INFO - Display: 09:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:51 INFO - Display Serial Number: 1600x1200 60 09:44:51 INFO - Main Display: Yes 09:44:51 INFO - Mirror: Off 09:44:51 INFO - Online: Yes 09:44:51 INFO - Rotation: Supported 09:44:51 INFO - Return code: 0 09:44:51 INFO - Running post-action listener: _resource_record_post_action 09:44:51 INFO - [mozharness: 2017-04-10 16:44:51.361778Z] Finished run-tests step (success) 09:44:51 INFO - Running post-run listener: _resource_record_post_run 09:44:51 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39234048; Write bytes: 519371776; Read time: 247; Write time: 1668 09:44:51 INFO - TinderboxPrint: CPU usage
54.3% 09:44:51 INFO - TinderboxPrint: I/O read bytes / time
39,234,048 / 247 09:44:51 INFO - TinderboxPrint: I/O write bytes / time
519,371,776 / 1,668 09:44:51 INFO - TinderboxPrint: CPU idle
2,192.3 (45.7%) 09:44:51 INFO - TinderboxPrint: CPU system
964.1 (20.1%) 09:44:51 INFO - TinderboxPrint: CPU user
1,641.4 (34.2%) 09:44:51 INFO - TinderboxPrint: Swap in / out
246,722,560 / 0 09:44:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193198592; Write bytes: 194504704; Read time: 14797; Write time: 426 09:44:51 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 38267392; Write bytes: 308020224; Read time: 233; Write time: 1192 09:44:51 INFO - Running post-run listener: _upload_blobber_files 09:44:51 INFO - Blob upload gear active. 09:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:51 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 09:44:51 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'] 09:44:51 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 09:44:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:53 INFO - (blobuploader) - INFO - Done attempting. 09:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:54 INFO - (blobuploader) - INFO - Done attempting. 09:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:55 INFO - (blobuploader) - INFO - Done attempting. 09:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:57 INFO - (blobuploader) - INFO - Done attempting. 09:44:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:57 INFO - Return code: 0 09:44:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7345b91cb3d552057ce39838ab15686ef3200199907708f1e7e91b62e67fdbb448f5e180e43d625f43b8b9d451b911f4d3b930e8342ce222950a4b223e3052bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbff59252e429ffdb908e2e3361750fdf3acfc90e1d0cebb1b1cd796aa83970021707574420ad505325196fe6f7614db1cb4a7b55b058bc71a20a2d061ff6a26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e095ff112ad27c186dcf953d4e6a4259372990efdcb54eff40f8049343587d37bd61e2a66a1d85321f9d5e24a26d138946ff1ce65f0d0274d2418ac95ab68c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679b53e361afcf786c6362a9cffbf2e90746221f358d21f513879f3be646289955c4df1dc24417065860e3b093220db6625c00dae570b75cce5142be031dfe79"} 09:44:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:57 INFO - Contents: 09:44:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7345b91cb3d552057ce39838ab15686ef3200199907708f1e7e91b62e67fdbb448f5e180e43d625f43b8b9d451b911f4d3b930e8342ce222950a4b223e3052bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbff59252e429ffdb908e2e3361750fdf3acfc90e1d0cebb1b1cd796aa83970021707574420ad505325196fe6f7614db1cb4a7b55b058bc71a20a2d061ff6a26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e095ff112ad27c186dcf953d4e6a4259372990efdcb54eff40f8049343587d37bd61e2a66a1d85321f9d5e24a26d138946ff1ce65f0d0274d2418ac95ab68c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679b53e361afcf786c6362a9cffbf2e90746221f358d21f513879f3be646289955c4df1dc24417065860e3b093220db6625c00dae570b75cce5142be031dfe79"} 09:44:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:57 INFO - Copying logs to upload dir... 09:44:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.342640 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-10 09:44:57.229688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 09:44:57.233671) ========= 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.UMcVmFgknR/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.2gJsmPUpF3/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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/7345b91cb3d552057ce39838ab15686ef3200199907708f1e7e91b62e67fdbb448f5e180e43d625f43b8b9d451b911f4d3b930e8342ce222950a4b223e3052bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbff59252e429ffdb908e2e3361750fdf3acfc90e1d0cebb1b1cd796aa83970021707574420ad505325196fe6f7614db1cb4a7b55b058bc71a20a2d061ff6a26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e095ff112ad27c186dcf953d4e6a4259372990efdcb54eff40f8049343587d37bd61e2a66a1d85321f9d5e24a26d138946ff1ce65f0d0274d2418ac95ab68c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679b53e361afcf786c6362a9cffbf2e90746221f358d21f513879f3be646289955c4df1dc24417065860e3b093220db6625c00dae570b75cce5142be031dfe79"} build_url:https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010522 build_url: 'https://queue.taskcluster.net/v1/task/PojvISciShCUD2sU6bwp5Q/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/7345b91cb3d552057ce39838ab15686ef3200199907708f1e7e91b62e67fdbb448f5e180e43d625f43b8b9d451b911f4d3b930e8342ce222950a4b223e3052bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbff59252e429ffdb908e2e3361750fdf3acfc90e1d0cebb1b1cd796aa83970021707574420ad505325196fe6f7614db1cb4a7b55b058bc71a20a2d061ff6a26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e095ff112ad27c186dcf953d4e6a4259372990efdcb54eff40f8049343587d37bd61e2a66a1d85321f9d5e24a26d138946ff1ce65f0d0274d2418ac95ab68c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679b53e361afcf786c6362a9cffbf2e90746221f358d21f513879f3be646289955c4df1dc24417065860e3b093220db6625c00dae570b75cce5142be031dfe79"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 09:44:57.269684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:44:57.270309) ========= 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.UMcVmFgknR/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.2gJsmPUpF3/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.004484 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 09:44:57.321222) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 09:44:57.321554) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 09:44:57.321875) ========= ========= Total master_lag: 0.16 =========