builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0274 starttime: 1491218954.27 results: success (0) buildid: 20170403031223 builduid: c061acd317254533ba1d5f4e91ffc07d revision: b2d106b73e6a4a1a8557981e597fea358b09d650 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:29:14.267096) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:29:14.267631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-04-03 04:29:14.267947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-04-03 04:29:17.686256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:29:17.686807) ========= 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.0mdc71FJah/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.7MwAPpw79y/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-03 04:29:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-04-03 04:29:18 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.472492 ========= master_lag: 0.69 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:29:18.849721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:29:18.850145) ========= 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.0mdc71FJah/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.7MwAPpw79y/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.039213 ========= master_lag: 1.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:29:20.101915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-03 04:29:20.102358) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b2d106b73e6a4a1a8557981e597fea358b09d650 --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 b2d106b73e6a4a1a8557981e597fea358b09d650 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0mdc71FJah/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.7MwAPpw79y/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-03 04:29:20,687 truncating revision to first 12 chars 2017-04-03 04:29:20,687 Setting DEBUG logging. 2017-04-03 04:29:20,687 attempt 1/10 2017-04-03 04:29:20,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b2d106b73e6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 04:29:24,333 unpacking tar archive at: mozilla-central-b2d106b73e6a/testing/mozharness/ program finished with exit code 0 elapsedTime=3.915903 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-04-03 04:29:24.614516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:29:24.614833) ========= script_repo_revision: b2d106b73e6a4a1a8557981e597fea358b09d650 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:29:24.615235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-04-03 04:29:24.615513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2017-04-03 04:29:27.018922) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2017-04-03 04:29:27.019833) ========= /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.0mdc71FJah/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.7MwAPpw79y/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:29:27 INFO - MultiFileLogger online at 20170403 04:29:27 in /builds/slave/test 04:29:27 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 04:29:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:27 INFO - {'append_to_log': False, 04:29:27 INFO - 'base_work_dir': '/builds/slave/test', 04:29:27 INFO - 'blob_upload_branch': 'Firefox', 04:29:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:27 INFO - 'branch': 'Firefox', 04:29:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:27 INFO - 'config_files': ('talos/mac_config.py',), 04:29:27 INFO - 'default_actions': ('clobber', 04:29:27 INFO - 'read-buildbot-config', 04:29:27 INFO - 'download-and-extract', 04:29:27 INFO - 'populate-webroot', 04:29:27 INFO - 'create-virtualenv', 04:29:27 INFO - 'install', 04:29:27 INFO - 'run-tests'), 04:29:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:27 INFO - 'download_minidump_stackwalk': True, 04:29:27 INFO - 'download_symbols': 'ondemand', 04:29:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:27 INFO - 'gecko_profile': False, 04:29:27 INFO - 'gecko_profile_interval': 0, 04:29:27 INFO - 'installer_path': 'installer.exe', 04:29:27 INFO - 'log_level': 'info', 04:29:27 INFO - 'log_name': 'talos', 04:29:27 INFO - 'log_to_console': True, 04:29:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:29:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:29:27 INFO - 'opt_config_files': (), 04:29:27 INFO - 'pip_index': False, 04:29:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:27 INFO - 'cmd': ('bash', 04:29:27 INFO - '-c', 04:29:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:27 INFO - 'enabled': True, 04:29:27 INFO - 'halt_on_failure': False, 04:29:27 INFO - 'name': 'check_screen_resolution'},), 04:29:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:27 INFO - 'cmd': ('bash', 04:29:27 INFO - '-c', 04:29:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:27 INFO - 'enabled': True, 04:29:27 INFO - 'halt_on_failure': False, 04:29:27 INFO - 'name': 'check_screen_resolution'},), 04:29:27 INFO - 'run_cmd_checks_enabled': True, 04:29:27 INFO - 'suite': 'dromaeojs-e10s', 04:29:27 INFO - 'system_bits': '32', 04:29:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:27 INFO - 'title': 't-yosemite-r7-0274', 04:29:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:27 INFO - 'use_talos_json': True, 04:29:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:27 INFO - 'work_dir': 'build'} 04:29:27 INFO - [mozharness: 2017-04-03 11:29:27.684302Z] Running clobber step. 04:29:27 INFO - Running pre-action listener: _resource_record_pre_action 04:29:27 INFO - Running main action method: clobber 04:29:27 INFO - rmtree: /builds/slave/test/build 04:29:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:30 INFO - Running post-action listener: _resource_record_post_action 04:29:30 INFO - [mozharness: 2017-04-03 11:29:30.196601Z] Finished clobber step (success) 04:29:30 INFO - [mozharness: 2017-04-03 11:29:30.196877Z] Running read-buildbot-config step. 04:29:30 INFO - Running pre-action listener: _resource_record_pre_action 04:29:30 INFO - Running main action method: read_buildbot_config 04:29:30 INFO - Using buildbot properties: 04:29:30 INFO - { 04:29:30 INFO - "project": "", 04:29:30 INFO - "product": "firefox", 04:29:30 INFO - "script_repo_revision": "production", 04:29:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:29:30 INFO - "repository": "", 04:29:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:29:30 INFO - "buildid": "20170403031223", 04:29:30 INFO - "pgo_build": "False", 04:29:30 INFO - "basedir": "/builds/slave/test", 04:29:30 INFO - "buildnumber": 13, 04:29:30 INFO - "slavename": "t-yosemite-r7-0274", 04:29:30 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:29:30 INFO - "platform": "yosemite_r7", 04:29:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:29:30 INFO - "branch": "mozilla-central", 04:29:30 INFO - "repo_path": "mozilla-central", 04:29:30 INFO - "revision": "b2d106b73e6a4a1a8557981e597fea358b09d650", 04:29:30 INFO - "stage_platform": "macosx64", 04:29:30 INFO - "builduid": "c061acd317254533ba1d5f4e91ffc07d", 04:29:30 INFO - "slavebuilddir": "test" 04:29:30 INFO - } 04:29:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:29:30 INFO - Running post-action listener: _resource_record_post_action 04:29:30 INFO - [mozharness: 2017-04-03 11:29:30.202748Z] Finished read-buildbot-config step (success) 04:29:30 INFO - [mozharness: 2017-04-03 11:29:30.202941Z] Running download-and-extract step. 04:29:30 INFO - Running pre-action listener: _resource_record_pre_action 04:29:30 INFO - Running main action method: download_and_extract 04:29:30 INFO - mkdir: /builds/slave/test/build/tests 04:29: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')]} 04:29:30 INFO - trying https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/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 04:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/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 04:29:34 INFO - Downloaded 1325 bytes. 04:29:34 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:29:34 INFO - Using the following test package requirements: 04:29:34 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:29:34 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:29:34 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:29:34 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:29:34 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'jsshell-mac.zip'], 04:29:34 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:29:34 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:29:34 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:29:34 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:29:34 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:29:34 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:34 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:29:34 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:29:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:29:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:29:34 INFO - Fetch https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:29:37 INFO - Expected file size: 52515598 04:29:37 INFO - Obtained file size: 52515598 04:29:53 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 04:29:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:29:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:29:53 INFO - Fetch https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:30:26 INFO - retry: attempt #1 caught exception: 04:30:26 INFO - retry: Failed, sleeping 60 seconds before retrying 04:31:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #2 04:31:26 INFO - Fetch https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:31:29 INFO - Expected file size: 52515598 04:31:29 INFO - Obtained file size: 52515598 04:31:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:31:44 INFO - Fetch https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:31:48 INFO - Expected file size: 14404152 04:31:48 INFO - Obtained file size: 14404152 04:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:48 INFO - trying https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:31:48 INFO - Downloading https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/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 04:31:51 INFO - Downloaded 75560403 bytes. 04:31:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:31:51 INFO - mkdir: /builds/slave/test/properties 04:31:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:51 INFO - Contents: 04:31:51 INFO - build_url:https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - Running post-action listener: set_extra_try_arguments 04:31:53 INFO - [mozharness: 2017-04-03 11:31:53.196800Z] Finished download-and-extract step (success) 04:31:53 INFO - [mozharness: 2017-04-03 11:31:53.196919Z] Running populate-webroot step. 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: populate_webroot 04:31:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:53 INFO - '--tppagecycles', 04:31:53 INFO - '7'], 04:31:53 INFO - 'tests': ['tsvgm']}}, 04:31:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['damp', 'tps']}, 04:31:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'tests': ['damp', 'tps']}, 04:31:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['dromaeo_dom']}, 04:31:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['basic_compositor_video']}, 04:31:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tsvgx', 04:31:53 INFO - 'tsvgr_opacity', 04:31:53 INFO - 'tart', 04:31:53 INFO - 'tscrollx', 04:31:53 INFO - 'cart', 04:31:53 INFO - 'tsvg_static']}, 04:31:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:53 INFO - 'tsvgr_opacity', 04:31:53 INFO - 'tart', 04:31:53 INFO - 'tscrollx', 04:31:53 INFO - 'cart', 04:31:53 INFO - 'tsvg_static']}, 04:31:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tp5o']}, 04:31:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:31:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s', 04:31:53 INFO - '--xperf_path', 04:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:53 INFO - 'tests': ['tp5n']}, 04:31:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:31:53 INFO - 'talos_options': ['--xperf_path', 04:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:53 INFO - 'tests': ['tp5n']}}, 04:31:53 INFO - 'talos.zip': {'path': '', 04:31:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - [mozharness: 2017-04-03 11:31:53.215172Z] Finished populate-webroot step (success) 04:31:53 INFO - [mozharness: 2017-04-03 11:31:53.215280Z] Running create-virtualenv step. 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: create_virtualenv 04:31:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:53 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 04:31:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:53 INFO - Using real prefix '/tools/python27' 04:31:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:56 INFO - Installing pip.................done. 04:31:56 INFO - Return code: 0 04:31:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:57 INFO - Reading from file tmpfile_stdout 04:31:57 INFO - Output received: 04:31:57 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) 04:31:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:31:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:57 INFO - 'HOME': '/Users/cltbld', 04:31:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:57 INFO - 'LOGNAME': 'cltbld', 04:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:57 INFO - 'MOZ_NO_REMOTE': '1', 04:31:57 INFO - 'NO_EM_RESTART': '1', 04:31:57 INFO - 'PAGER': '/bin/cat', 04:31:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:57 INFO - 'PWD': '/builds/slave/test', 04:31:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:57 INFO - 'SHELL': '/bin/bash', 04:31:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:31:57 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:31:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:57 INFO - 'USER': 'cltbld', 04:31:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:57 INFO - 'XPC_FLAGS': '0x0', 04:31:57 INFO - 'XPC_SERVICE_NAME': '0', 04:31:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:58 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 04:31:58 INFO - Cleaning up... 04:31:58 INFO - Return code: 0 04:31:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:58 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')]} 04:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:58 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')]} 04:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:58 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:31:58 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 04:31:58 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 04:31:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:31:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:58 INFO - 'HOME': '/Users/cltbld', 04:31:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:58 INFO - 'LOGNAME': 'cltbld', 04:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:58 INFO - 'MOZ_NO_REMOTE': '1', 04:31:58 INFO - 'NO_EM_RESTART': '1', 04:31:58 INFO - 'PAGER': '/bin/cat', 04:31:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:58 INFO - 'PWD': '/builds/slave/test', 04:31:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:58 INFO - 'SHELL': '/bin/bash', 04:31:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:31:58 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:31:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:58 INFO - 'USER': 'cltbld', 04:31:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:58 INFO - 'XPC_FLAGS': '0x0', 04:31:58 INFO - 'XPC_SERVICE_NAME': '0', 04:31:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:58 INFO - Downloading/unpacking psutil>=3.1.1 04:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:03 INFO - Installing collected packages: psutil 04:32:03 INFO - Running setup.py install for psutil 04:32:03 INFO - building 'psutil._psutil_osx' extension 04:32:03 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 04:32:03 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 04:32:03 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 04:32:04 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 04:32:04 INFO - building 'psutil._psutil_posix' extension 04:32:04 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 04:32:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:04 INFO - ^ 04:32:04 INFO - 1 warning generated. 04:32:04 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 04:32:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:04 INFO - Successfully installed psutil 04:32:04 INFO - Cleaning up... 04:32:04 INFO - Return code: 0 04:32:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:04 INFO - 'HOME': '/Users/cltbld', 04:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:04 INFO - 'LOGNAME': 'cltbld', 04:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:04 INFO - 'MOZ_NO_REMOTE': '1', 04:32:04 INFO - 'NO_EM_RESTART': '1', 04:32:04 INFO - 'PAGER': '/bin/cat', 04:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:04 INFO - 'PWD': '/builds/slave/test', 04:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:04 INFO - 'SHELL': '/bin/bash', 04:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:04 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:04 INFO - 'USER': 'cltbld', 04:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:04 INFO - 'XPC_FLAGS': '0x0', 04:32:04 INFO - 'XPC_SERVICE_NAME': '0', 04:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:08 INFO - Installing collected packages: mozsystemmonitor 04:32:08 INFO - Running setup.py install for mozsystemmonitor 04:32:08 INFO - Successfully installed mozsystemmonitor 04:32:08 INFO - Cleaning up... 04:32:08 INFO - Return code: 0 04:32:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:08 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 04:32:08 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 04:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:08 INFO - 'HOME': '/Users/cltbld', 04:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:08 INFO - 'LOGNAME': 'cltbld', 04:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:08 INFO - 'MOZ_NO_REMOTE': '1', 04:32:08 INFO - 'NO_EM_RESTART': '1', 04:32:08 INFO - 'PAGER': '/bin/cat', 04:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:08 INFO - 'PWD': '/builds/slave/test', 04:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:08 INFO - 'SHELL': '/bin/bash', 04:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:08 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:08 INFO - 'USER': 'cltbld', 04:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:08 INFO - 'XPC_FLAGS': '0x0', 04:32:08 INFO - 'XPC_SERVICE_NAME': '0', 04:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:09 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 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 04:32:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:12 INFO - warning: no files found matching '*.txt' 04:32:12 INFO - no previously-included directories found matching 'build' 04:32:12 INFO - no previously-included directories found matching 'dist' 04:32:12 INFO - no previously-included directories found matching '.git*' 04:32:12 INFO - Installing collected packages: jsonschema, functools32 04:32:12 INFO - Running setup.py install for functools32 04:32:13 INFO - warning: no files found matching '*.txt' 04:32:13 INFO - no previously-included directories found matching 'build' 04:32:13 INFO - no previously-included directories found matching 'dist' 04:32:13 INFO - no previously-included directories found matching '.git*' 04:32:13 INFO - Successfully installed jsonschema functools32 04:32:13 INFO - Cleaning up... 04:32:13 INFO - Return code: 0 04:32:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:13 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 04:32:13 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 04:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:13 INFO - 'HOME': '/Users/cltbld', 04:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:13 INFO - 'LOGNAME': 'cltbld', 04:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:13 INFO - 'MOZ_NO_REMOTE': '1', 04:32:13 INFO - 'NO_EM_RESTART': '1', 04:32:13 INFO - 'PAGER': '/bin/cat', 04:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:13 INFO - 'PWD': '/builds/slave/test', 04:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:13 INFO - 'SHELL': '/bin/bash', 04:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:13 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:13 INFO - 'USER': 'cltbld', 04:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:13 INFO - 'XPC_FLAGS': '0x0', 04:32:13 INFO - 'XPC_SERVICE_NAME': '0', 04:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:13 INFO - Cleaning up... 04:32:13 INFO - Return code: 0 04:32:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:13 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 04:32:13 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 04:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:13 INFO - 'HOME': '/Users/cltbld', 04:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:13 INFO - 'LOGNAME': 'cltbld', 04:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:13 INFO - 'MOZ_NO_REMOTE': '1', 04:32:13 INFO - 'NO_EM_RESTART': '1', 04:32:13 INFO - 'PAGER': '/bin/cat', 04:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:13 INFO - 'PWD': '/builds/slave/test', 04:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:13 INFO - 'SHELL': '/bin/bash', 04:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:13 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:13 INFO - 'USER': 'cltbld', 04:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:13 INFO - 'XPC_FLAGS': '0x0', 04:32:13 INFO - 'XPC_SERVICE_NAME': '0', 04:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:13 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 04:32:13 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 04:32:13 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 04:32:13 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 04:32:13 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 04:32:13 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 04:32:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Downloading docopt-0.6.1.tar.gz 04:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:17 INFO - Running setup.py install for blobuploader 04:32:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:18 INFO - Running setup.py install for requests 04:32:18 INFO - Running setup.py install for docopt 04:32:18 INFO - Successfully installed blobuploader requests docopt 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:18 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')]} 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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')]} 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:18 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:18 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 04:32:18 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 04:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:18 INFO - 'HOME': '/Users/cltbld', 04:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PAGER': '/bin/cat', 04:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:18 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - 'XPC_FLAGS': '0x0', 04:32:18 INFO - 'XPC_SERVICE_NAME': '0', 04:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-87X68b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iaU5zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-3LtDL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yusWQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-q77brv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fShx3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-BkaasN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1hRw6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-5YvL0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-mu2tIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-PVJQQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Q8zehe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iddIRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jxIdCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-rOAkSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AjneIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-UpWVxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:20 INFO - Running setup.py install for manifestparser 04:32:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozcrash 04:32:21 INFO - Running setup.py install for mozdebug 04:32:21 INFO - Running setup.py install for mozdevice 04:32:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozfile 04:32:21 INFO - Running setup.py install for mozhttpd 04:32:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozinfo 04:32:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:21 INFO - Running setup.py install for mozInstall 04:32:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozleak 04:32:22 INFO - Running setup.py install for mozlog 04:32:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for moznetwork 04:32:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozprocess 04:32:22 INFO - Running setup.py install for mozprofile 04:32:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:22 INFO - Running setup.py install for mozrunner 04:32:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Running setup.py install for mozscreenshot 04:32:23 INFO - Running setup.py install for moztest 04:32:23 INFO - Running setup.py install for mozversion 04:32:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:23 INFO - Cleaning up... 04:32:23 INFO - Return code: 0 04:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:23 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')]} 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 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')]} 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:23 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 04:32:23 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 04:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:23 INFO - 'HOME': '/Users/cltbld', 04:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:23 INFO - 'LOGNAME': 'cltbld', 04:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:23 INFO - 'MOZ_NO_REMOTE': '1', 04:32:23 INFO - 'NO_EM_RESTART': '1', 04:32:23 INFO - 'PAGER': '/bin/cat', 04:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:23 INFO - 'PWD': '/builds/slave/test', 04:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:23 INFO - 'SHELL': '/bin/bash', 04:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:23 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:23 INFO - 'USER': 'cltbld', 04:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:23 INFO - 'XPC_FLAGS': '0x0', 04:32:23 INFO - 'XPC_SERVICE_NAME': '0', 04:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-XlAg5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:23 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)) 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-GDmLTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:23 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)) 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-TZ4BxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-5btu3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-zsMu_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-vJRyBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-hU9km4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-6pmbwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-UhtE9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-qj96Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-UHYGsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:24 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)) 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yyb4h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:25 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)) 04:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:25 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-A0izba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:25 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)) 04:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:25 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-3PYPX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:25 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)) 04:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:25 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-mxE3GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:25 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)) 04:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:25 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-p6L8ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:25 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)) 04:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:25 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dbtJhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:25 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)) 04:32:25 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)) 04:32:25 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)) 04:32:25 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)) 04:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:25 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 04:32:25 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 04:32:25 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 04:32:25 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 04:32:25 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 04:32:25 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 04:32:28 INFO - Downloading blessings-1.6.tar.gz 04:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:28 INFO - Installing collected packages: blessings 04:32:28 INFO - Running setup.py install for blessings 04:32:28 INFO - Successfully installed blessings 04:32:28 INFO - Cleaning up... 04:32:28 INFO - Return code: 0 04:32:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:28 INFO - Reading from file tmpfile_stdout 04:32:28 INFO - Current package versions: 04:32:28 INFO - blessings == 1.6 04:32:28 INFO - blobuploader == 1.2.4 04:32:28 INFO - docopt == 0.6.1 04:32:28 INFO - functools32 == 3.2.3-2 04:32:28 INFO - jsonschema == 2.5.1 04:32:28 INFO - manifestparser == 1.1 04:32:28 INFO - mozInstall == 1.12 04:32:28 INFO - mozcrash == 1.0 04:32:28 INFO - mozdebug == 0.1 04:32:28 INFO - mozdevice == 0.49 04:32:28 INFO - mozfile == 1.2 04:32:28 INFO - mozhttpd == 0.7 04:32:28 INFO - mozinfo == 0.9 04:32:28 INFO - mozleak == 0.1 04:32:28 INFO - mozlog == 3.4 04:32:28 INFO - moznetwork == 0.27 04:32:28 INFO - mozprocess == 0.25 04:32:28 INFO - mozprofile == 0.28 04:32:28 INFO - mozrunner == 6.13 04:32:28 INFO - mozscreenshot == 0.1 04:32:28 INFO - mozsystemmonitor == 0.3 04:32:28 INFO - moztest == 0.8 04:32:28 INFO - mozversion == 1.4 04:32:28 INFO - psutil == 3.1.1 04:32:28 INFO - requests == 1.2.3 04:32:28 INFO - wsgiref == 0.1.2 04:32:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:28 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')]} 04:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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')]} 04:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:28 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:28 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 04:32:28 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 04:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:28 INFO - 'HOME': '/Users/cltbld', 04:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:28 INFO - 'LOGNAME': 'cltbld', 04:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:28 INFO - 'MOZ_NO_REMOTE': '1', 04:32:28 INFO - 'NO_EM_RESTART': '1', 04:32:28 INFO - 'PAGER': '/bin/cat', 04:32:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:28 INFO - 'PWD': '/builds/slave/test', 04:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:28 INFO - 'SHELL': '/bin/bash', 04:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:28 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:28 INFO - 'USER': 'cltbld', 04:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:28 INFO - 'XPC_FLAGS': '0x0', 04:32:28 INFO - 'XPC_SERVICE_NAME': '0', 04:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 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)) 04:32:29 INFO - Cleaning up... 04:32:29 INFO - Return code: 0 04:32:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:29 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')]} 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:29 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')]} 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:29 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 0x108ac2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ac5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd92345bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, '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.0mdc71FJah/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.7MwAPpw79y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 04:32:29 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 04:32:29 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 04:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:29 INFO - 'HOME': '/Users/cltbld', 04:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:29 INFO - 'LOGNAME': 'cltbld', 04:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:29 INFO - 'MOZ_NO_REMOTE': '1', 04:32:29 INFO - 'NO_EM_RESTART': '1', 04:32:29 INFO - 'PAGER': '/bin/cat', 04:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:29 INFO - 'PWD': '/builds/slave/test', 04:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:29 INFO - 'SHELL': '/bin/bash', 04:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:29 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:29 INFO - 'USER': 'cltbld', 04:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:29 INFO - 'XPC_FLAGS': '0x0', 04:32:29 INFO - 'XPC_SERVICE_NAME': '0', 04:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:29 INFO - Cleaning up... 04:32:29 INFO - Return code: 0 04:32:29 INFO - Running post-action listener: _resource_record_post_action 04:32:29 INFO - Running post-action listener: _start_resource_monitoring 04:32:29 INFO - Starting resource monitoring. 04:32:29 INFO - [mozharness: 2017-04-03 11:32:29.355314Z] Finished create-virtualenv step (success) 04:32:29 INFO - [mozharness: 2017-04-03 11:32:29.356274Z] Running install step. 04:32:29 INFO - Running pre-action listener: _resource_record_pre_action 04:32:29 INFO - Running main action method: install 04:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:29 INFO - Reading from file tmpfile_stdout 04:32:29 INFO - Output received: 04:32:29 INFO - Usage: mozinstall [options] installer 04:32:29 INFO - Options: 04:32:29 INFO - -h, --help show this help message and exit 04:32:29 INFO - -d DEST, --destination=DEST 04:32:29 INFO - Directory to install application into. [default: 04:32:29 INFO - "/builds/slave/test"] 04:32:29 INFO - --app=APP Application being installed. [default: firefox] 04:32:29 INFO - mkdir: /builds/slave/test/build/application 04:32:29 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'] 04:32:29 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 04:32:49 INFO - Reading from file tmpfile_stdout 04:32:49 INFO - Output received: 04:32:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:32:49 INFO - Running post-action listener: _resource_record_post_action 04:32:49 INFO - [mozharness: 2017-04-03 11:32:49.936992Z] Finished install step (success) 04:32:49 INFO - [mozharness: 2017-04-03 11:32:49.937135Z] Running run-tests step. 04:32:49 INFO - Running pre-action listener: _resource_record_pre_action 04:32:49 INFO - Running main action method: run_tests 04:32:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:49 INFO - 2017-04-03 04:32:49.951 screenresolution[1640:7975] starting screenresolution argv=screenresolution get 04:32:49 INFO - 2017-04-03 04:32:49.954 screenresolution[1640:7975] Display 0: 1600x1200x32@60 04:32:49 INFO - 2017-04-03 04:32:49.960 screenresolution[1641:7977] starting screenresolution argv=screenresolution list 04:32:49 INFO - Available Modes on Display 0 04:32:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:50 INFO - Intel Iris: 04:32:50 INFO - Chipset Model: Intel Iris 04:32:50 INFO - Type: GPU 04:32:50 INFO - Bus: Built-In 04:32:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:50 INFO - Vendor: Intel (0x8086) 04:32:50 INFO - Device ID: 0x0a2e 04:32:50 INFO - Revision ID: 0x0009 04:32:50 INFO - Displays: 04:32:50 INFO - Display: 04:32:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:50 INFO - Display Serial Number: 1600x1200 60 04:32:50 INFO - Main Display: Yes 04:32:50 INFO - Mirror: Off 04:32:50 INFO - Online: Yes 04:32:50 INFO - Rotation: Supported 04:32:50 INFO - Return code: 0 04:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:50 INFO - Python 2.7.3 04:32:50 INFO - Return code: 0 04:32:50 INFO - grabbing minidump binary from tooltool 04:32: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')]} 04:32:50 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 0x1088a0d30>, '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 0x1087c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108895be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:50 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 04:32:50 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 04:32:50 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 04:32:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:50 INFO - Return code: 0 04:32:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:32:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:50 INFO - ENV: RUST_BACKTRACE is now 1 04:32:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:32:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:50 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/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 04:32:50 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/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 04:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0mdc71FJah/Render', 04:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:50 INFO - 'HOME': '/Users/cltbld', 04:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:50 INFO - 'LOGNAME': 'cltbld', 04:32:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:50 INFO - 'MOZ_NO_REMOTE': '1', 04:32:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:50 INFO - 'NO_EM_RESTART': '1', 04:32:50 INFO - 'PAGER': '/bin/cat', 04:32:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:50 INFO - 'PWD': '/builds/slave/test', 04:32:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:50 INFO - 'RUST_BACKTRACE': '1', 04:32:50 INFO - 'SHELL': '/bin/bash', 04:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7MwAPpw79y/Listeners', 04:32:50 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 04:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:50 INFO - 'USER': 'cltbld', 04:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:50 INFO - 'XPC_FLAGS': '0x0', 04:32:50 INFO - 'XPC_SERVICE_NAME': '0', 04:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:50 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/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 04:32:50 INFO - mozversion application_buildid: 20170403031223 04:32:50 INFO - mozversion application_changeset: b2d106b73e6a4a1a8557981e597fea358b09d650 04:32:50 INFO - mozversion application_display_name: Nightly 04:32:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:50 INFO - mozversion application_name: Firefox 04:32:50 INFO - mozversion application_remotingname: firefox 04:32:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:50 INFO - mozversion application_vendor: Mozilla 04:32:50 INFO - mozversion application_version: 55.0a1 04:32:50 INFO - mozversion platform_buildid: 20170403031223 04:32:50 INFO - mozversion platform_changeset: b2d106b73e6a4a1a8557981e597fea358b09d650 04:32:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:50 INFO - mozversion platform_version: 55.0a1 04:32:50 INFO - using testdate: 1491219170 04:32:50 INFO - actual date: 1491219170 04:32:50 INFO - starting webserver on 'localhost:49250' 04:32:50 INFO - SUITE-START | Running 2 tests 04:32:50 INFO - TEST-START | dromaeo_css 04:32:50 INFO - operating with platform_type : mac_ 04:32:50 INFO - Initialising browser for dromaeo_css test... 04:32:50 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpyHcAmi/profile http://localhost:49250/getInfo.html) 04:32:53 INFO - PID 1651 | 2017-04-03 04:32:53.506 plugin-container[1652:8141] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:32:53 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:53 INFO - PID 1651 | 2017-04-03 04:32:53.509 plugin-container[1652:8141] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 04:32:53 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:53 INFO - PID 1651 | 2017-04-03 04:32:53.509 plugin-container[1652:8141] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:53 INFO - PID 1651 | __metrics Screen width/height:1600/1200 04:32:53 INFO - PID 1651 | colorDepth:24 04:32:53 INFO - PID 1651 | Browser inner width/height: 1024/689 04:32:53 INFO - PID 1651 | __metrics 04:32:53 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:32:54 INFO - TEST-INFO | 1651: exit 0 04:32:54 INFO - Browser initialized. 04:32:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:54 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpyHcAmi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:56 INFO - PID 1654 | 2017-04-03 04:32:56.926 plugin-container[1655:8271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:32:56 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:56 INFO - PID 1654 | 2017-04-03 04:32:56.926 plugin-container[1655:8271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 04:32:56 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:56 INFO - PID 1654 | 2017-04-03 04:32:56.926 plugin-container[1655:8271] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:33:06 INFO - PID 1654 | RSS: Main: 228786176 04:33:06 INFO - PID 1654 | 04:36:10 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 04:36:12 INFO - PID 1654 | RSS: Main: 253526016 04:36:12 INFO - PID 1654 | 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 04:37:55 INFO - PID 1654 | 04:37:55 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:55 INFO - PID 1654 | Full stack: 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 04:37:55 INFO - PID 1654 | 04:37:55 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:55 INFO - PID 1654 | Full stack: 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 04:37:55 INFO - PID 1654 | 04:37:55 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:55 INFO - PID 1654 | Full stack: 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | ************************* 04:37:55 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 04:37:55 INFO - PID 1654 | 04:37:55 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:37:55 INFO - PID 1654 | Full stack: 04:37:55 INFO - PID 1654 | ************************* 04:39:14 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 04:39:15 INFO - PID 1654 | RSS: Main: 262361088 04:39:15 INFO - PID 1654 | 04:42:16 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 04:42:17 INFO - PID 1654 | RSS: Main: 272621568 04:42:17 INFO - PID 1654 | 04:45:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 04:45:19 INFO - PID 1654 | RSS: Main: 266260480 04:45:19 INFO - PID 1654 | 04:48:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 04:48:23 INFO - PID 1654 | RSS: Main: 279748608 04:48:23 INFO - PID 1654 | 04:51:25 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 04:51:26 INFO - PID 1654 | RSS: Main: 273379328 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | __start_tp_report 04:51:26 INFO - PID 1654 | _x_x_mozilla_page_load 04:51:26 INFO - PID 1654 | _x_x_mozilla_page_load_details 04:51:26 INFO - PID 1654 | |i|pagename|runs| 04:51:26 INFO - PID 1654 | |0;dojo.html;3532.7703699259546;3555.253396786675;3581.6597423244816;3598.784072955623;3610.115521697184;6133.151048553284;6186.381361863817;6193.659348735818;6194.7212375443105;6239.34486878878;6156.445919867211;6162.907556386658;6164.352742961992;6233.407826256498;6241.625502469855;5429.077056900317;5473.28847249857;5532.529734972532;5558.44415558443;5576.470235327637;5423.3491980962335;5471.398146203935;5564.944350556483;5576.525995290405;5579.944200557983;5395;5472.534834539069;5502.8349149525575;5516.365617953907;5555.194496797962;5460.099083651193;5479.2602998595075;5499.587530935156;5525.309336332958;5537.307836520435;5406.648567843077;5422.9728851355885;5424.321959755031;5433.646812957145;5467.875978903653;6063.393660633946;6101.481374083208;6145.78489752861;6147.770445910835;6187.226596675416;6666.699998500079;6678.933210667879;6711.597304161717;6720.932790672079;6734.8316292092595;5723.826615543803;6118.4799292060225;6801.863962720768;6809.727610895558;6874.9656251718925;6162.815115546541;6192.783252586138;6284.87430251397;6327.968360158262;6346.619202847844;5830.941690583125;6817.659117044128;6837.863242735118;6900.137482814648;6922.757703480354;6308.810735677937;6327.050942358591;6435.06691529735;6536.509761767887;6591.406773390322;6710.664466776641;6763.864722705617;6765.864682706417;6785;6800.149981252343;5444.992676354887;6376.107344971708;6671.699773510204;6676.766313179112;6677.465802735769;6448.677566121675;6466.644334561644;6604.471642268607;6635.2037755469655;6700.262971073178;4581.496035436099;4666;5293.206019097166;5302.946970530245;5345.198220266913;4738.3129446230105;4754.02542478791;4769;4775.928361074587;4794.640401969797;6111.682900513584;6209;6217.347178546188;6223.1287619733275;6241.96879015602;6828.146481689789;6848.486363522756;6852.109225800614;6860.725570977205;6866.759663411856;5286.709230992333;6141.263048434216;6306.558540902093;6308.653024083627;6328.430441260309;5757.798477053283;5829.300483941955;5840.766369345179;5845.620034697731;6020.277566692025;6644.767433139817;6662.367075127855;6733.158355205599;6778.966105169443;6792.728290868507;6773.356531129732;6784.3894049535775;6787.626680532618;6788.728450862108;6810.250872404131;5760.6255593386295;6751.56114852533;6782.641524430172;6835;6836.931630683828;5482.342118945752;6357.96821015892;6467.385598368148;6676.332366763285;6679.666016699242;6798.694058767466;6800.421964132906;6809.353111454404;6811.421029212374;6812.795616131524;6327.2407311121115;6429.7428102875365;6471.708773105127;6521.347865213441;6577.079208910852;6513.576617519846;6556.442702370352;6615.106960560262;6627.635480048643;6635.9004614929845;5234.502722241381;5319.335083114611;5625.240592519957;6329.8734025320155;6372;5741.794223213005;6291.496680265659;6515.869682606416;6563.0811686362995;6567;6373.235211774617;6379.170707807955;6379.298277189599;6395.936040639534;6400.135981642418 04:51:26 INFO - PID 1654 | |1;ext.html;760.2017881224713;779.3764988009592;838.0990435282073;1056.96300629478;1279.2324605236859;39864.402033969476;40927;40957.771266861964;40978.38532422016;40990.59009409909;40070.79787606376;40255.798721006424;40472;40526.18947621046;40560.79719601405;7726.227377262257;8080.757577272691;8183.018037835468;8371.874421883645;8546.188112129337;8658.307335413183;8799.29605631548;8811.427257228292;8851.203391694778;8854.291656667483;8751.95624021879;8821.60302786373;8832.851729275217;8838.73483795484;8842;8751.693690720826;8783.902012248469;8802.955985220065;8831.69089081879;8833.690820821304;8459.619317130682;8482.53346065966;8536.957315213383;8538.103499132625;8550.74347769568;39836.402453963216;39899.80300590987;40175.19649607021;40262.798686006674;40351.798241008604;3028.7543106656544;3057.021753039028;3063.0657649416917;3066.2027872753247;3067.079876037202;28659.42681146386;28698.282542936384;28771.71228287732;28956.986505472418;29786.851065744748;2796.175128337125;2798.3423895384567;2806.480801051812;2807.6490438695164;2819.3797364579964;278754;284950;294800;335482.32258838793;337169;49155.508444915096;49468.75265623721;49474.75262623664;49528;49556;51433.14251431158;51749.741251294254;51839;51890;51897.740511297205;14437.422503099968;14594.927025364805;14603.78094328586;14615;14619.195944222956;12008.699782505508;12066;12083.214591051554;12095.27428354284;12100.152989290842;13776.93111534456;13894.444222230997;13996.230207338695;14053.929730351283;14076.225807580682;6043.637381757108;6059.7273122709585;6061.515078793774;6071.241094863142;6078.149059131725;858.6947839284253;986.7237173591406;988.5897352598591;992.9156021738089;1029.8712660917386;28524.857375713404;29648.962286319875;29726.25684357908;30057.849710751307;30993.8450307747;1052.3002203534718;1055.3667799320347;1089.6730980705756;1096.3531516405199;1100.7523307255804;10897.400642964712;11869.525218991317;11969.264456653736;12314.938425307995;12415.689607759878;403065;451108;452149;452774;453636.7318163454;55005.174922376194;55121;55360;55909;55987.44012559904;1329.5944736855158;1417.4471955937192;1470.9705805883823;1473.5800296915327;1475.4614565683662;18992.43022709321;19907.303244386956;21662.025208865325;23369.41576460602;24089.397765056015;31962;38445.807770960964;38590.614093858705;38786.41820372753;38801.447942082;395241;396177;397235;397633;398058;34096.69211195937;35499.467507987916;36197.63802361942;36248.637513624526;36344.00215976293;43268.56731432645;43609.34585981276;44287.11425771531;44867;44976.77511612421;30552.694473054984;30645;31498.37003259968;31671.366572668878;31868.68131318657;28414.57378139371;30787.692123078483;31257.062288131394;31652.841735791175;31783.364332713678;36413.635863642085;36931.07672308106;36995.26009479849;37344;37439.43840842444;25105.121320753686;25564.872175639004;30236.69763302339;30475.085747427613;31530.842345788125;24309.270721878373;24822.751772482043;24885.751142488345;25370.238892832505;25446.745532545177 04:51:26 INFO - PID 1654 | |2;jquery.html;395.7961649750379;415.50347334934764;415.51799912101967;425.8743670617168;439.94500687414074;17648.85282456641;20918.581628367425;21123.15507379705;22155.667664985038;22309.776902230973;22789.772102278974;22905.198318058872;23395.88302058487;23409.82950852459;23600.64599031016;6074.058520929263;6411.1024456576115;6412;6444.967775161118;6454.225492940854;6029.1257767623665;6241.812745617616;6272.372762723737;6341.334159913212;6348.0477928310665;5441.347038355403;6043.8186854394435;6271.247450305969;6296.590721603104;6318.083877837711;5612.747426365823;6117.898778219918;6183.381661833803;6370.713317900682;6373.757117362116;5374.220737992969;5539.833804985857;5629.831105066854;5638.379778224433;5651.9152212716845;26997.920083196845;27607;29735.70264297351;29886.252843678863;30853.691463085306;2118.872867627932;2121.8726876387313;2153.720016397874;2203.0857194264363;2226.398872304485;16179.35282588695;17720.645587088315;17803.73294400585;18254.17856196461;18307.35924242645;1948.6395016921915;2029.3708950225478;2034.4201902457728;2040.357287454462;2053.784352642966;163107.1844640781;176399;177152.114239428;178515.21484784986;181199;21518.56962860734;26091.95632174692;26439.867800661257;26758.464830703277;26935.326616834736;42400.15199695989;42687;42693;43024.78487607542;43302.56697433048;9401.952990235006;11409.42952852354;11453.942730286295;11530.135239857043;11575.942120289345;8869;8882.333824963154;8898.777530561658;8912.064233255414;8998.460092394478;10241.948790256001;11322.69788974262;11512.445819814218;11752.882471175179;11822.645320640395;4120.546739858613;4694;4697.976510117496;4701.529847015271;4722.693024953367;824.6704799801045;885.9468431894107;919.5494207838245;962.7400601837604;995.7759504111517;20834.89582552108;21278.574428511343;21393.89303053506;21425.357239282846;21513.462163446038;871.8622198031503;898.4294972692256;971.4171497101682;999.6101520407047;1011.7824667696333;10932.067932067932;10995.285306455055;11166.441677916235;11202.38386888729;11208.66374008781;695373;701855;713423;717461;724452;146477;154011.45988540194;160463;164943;167651;1160.1125139268465;1169.222467059413;1208.3052244959183;1209.866914639389;1210.1770795858724;20857.478563036046;22363.776362236822;22443.32670019902;22537;22681.773182268626;51234.74382628063;63248;63366.68316658387;63460;63502.68248658727;90016.54991725;90259;90595.54702226447;90621;93110.53444733004;12078.51685932588;12183.451744671334;12524.937375313066;12871.712828717053;12906.806397904227;13633.863661363259;13819.378127984064;13937.512187073404;13938.721225575635;14126.434942602591;10085.344452610558;10756.408397538211;10937.234393592691;11785.823212651645;11852.466639001093;10059.346142500714;10911;11002.229843910849;11156.832647510457;11176.776464470828;11534.192606517463;11570.652880413601;11711.824322635337;12027.579034733742;12137.393130343624;12423.937880310541;12516.311602861566;12853.293068881301;12903.354832258537;13178.143420677625;10877.836832447361;11118.221724479208;11634.70913227176;11991.22057066288;12035.518579257083 04:51:26 INFO - PID 1654 | |3;mootools.html;1230.772307123182;1332.726791007844;1422.1751384197166;1426.2654732812603;1441.3585954250357;10755.83866242007;11137.72155696108;11230.045446137077;11252.15608829338;11257.43712814358;11072.612458563952;11168;11215.439228038606;11225.438728063606;11225.719357016078;2450.362905644532;2477.1453848422357;2482.0692240409844;2482.503499300138;2483.863387513686;2363.5036642305136;2380.27401642499;2381.142788596104;2385.129427758864;2395.1138078910826;2330.242671131889;2356.96464553031;2368.786809187173;2452.877356132195;2462.9753702463013;2270.489139943516;2400.4838959623676;2407.410184504799;2410.108259943832;2433.3186707721866;2056.9177232910665;2136.957260854774;2355.705536807899;2395.6406539019113;2409.6024156014237;11075.280106793114;11095.944520277348;11161.330320180816;11178.720531986684;11206.887931120666;5796.855078623026;6300.117983482316;6304.684765761694;6325.430711236011;6331.493480521547;3828.5214348206473;3903.8438462461468;3907.6678482329035;3928.4696565963513;3997.2405243003736;1212.2302338015336;1534.3709079277442;1575.58247064528;1604.2620394618489;1635.4848222809896;12891.87108128916;14201.218932958684;15197.392104315813;15206.847931520653;15227.086374817436;5221.216817477409;5446.754896029688;5479.726013699299;5486.067368547357;5550.528205102531;11409.03023243017;11470.369129697947;11497.080233581293;11507.19449638534;11515.942420288013;6241.812745617639;6305.716242769086;6320.652364119926;6321.241451025906;6332.556721029576;5595.552355811526;5760.963026655242;5763.135529670583;5841.9415805842245;5979.551533634908;4083.530394004668;4208.8316467340965;4259.61663450291;4262.339337402707;4305.74165550068;1211.787937111002;1216.4404373987888;1225.1301575881046;1227.1900545640012;1228.6068458093325;626.5676683088654;746.73117677636;769.2461387839949;770.9961450192714;781.3788038509399;5004.4995500450395;5701.287339082614;5801.361850196475;6007.429294217042;6051.334353221142;563.7575842387813;567.9403662615448;589.1016200294586;596.0522768797632;599.1701493431628;3739.495168152319;4044.6157615026527;4120.567340429272;4250.341197114452;4325.4593175853015;13053;14210.431582736781;14218.644533886736;14243;14272.928635356964;13703.314834258248;13783.035187536976;14007.49474818739;14140.43438262458;14223.573292801233;10188.032136946978;10254.897451025543;10267.870534241227;10313.535890885078;10367.844482332772;6460.644664543495;6474.708638111202;6487.870242595216;6535.607863528204;6648.135742353463;11217.66347009591;12336.81494777561;12353.444095015926;12629.747405051663;12653.051021173265;12834.422450989914;12837.807432888327;12999;13090.280034598189;13113.147645403018;8182.681257182879;8272.710455134042;8293.668253269801;8392.03491598474;8402.579871006548;10075.848862266925;10111.3427627204;10154.339967902062;10233.897661023593;10237.897621023694;7332.706691732485;8408.864803251483;8644.654213831376;8670.696525621574;8724.127587241224;8416.957915210629;8535.061143274359;8546.316294696533;8615.439996400213;8660.48037117775;6944.756933507303;7728.26581474759;7812.3750099993;7939.603019848869;7941.642626081724;5276.76254568553;5867.882642347215;5969.701514924323;6036.154938308552;6075.969620151871;5844.6493210405815;5864.648121112747;6051.577879198297;6089.756409743561;6236.126942228001 04:51:26 INFO - PID 1654 | |4;prototype.html;353.81955202846547;381.28509045539613;383.08824996508343;398.9920201595968;403.6931931731885;6163.722632481538;6354.936450635492;6418.19772528434;6457.3865482779065;6507.479401647869;6094.664793436359;6273;6290.433860952513;6295.811125666238;6311.905321420182;3760;4177.908347822605;4802.519748025195;4808.495108013661;4820.638452116105;3971.4837071180705;4590.954090459103;4733.502982186872;4734.360861283717;4815.277708343741;4331.43691320128;4551.499335073139;4708.646851486135;4712.078511322985;4726.952730472703;4732.313814496896;4745.406824146981;4754.0967216229155;4762.785674644615;4763.880902977418;4006.979965100156;4162.458880345566;4199.9790001050105;4210.978945105286;4220.345846393814;4956.826511072131;5804.216430781833;5942.494887934531;6084.482818960394;6176.629402235835;5615.691136987464;5630.71846407678;5643.548516118701;5646.350669672999;5649.491545760901;6458.2895881453005;6688.829454845382;6748.797536073926;6773.288804675487;6796.184457865038;4162.8353256306555;4203.4115223868685;4633.582977532038;4792;4800.519948005206;6086.113304875503;6206.410391012847;6797.422219111381;6970.651467426659;7187.676554555058;4084.244414783275;4623.514530974267;4859.319695242598;4894.632902532324;4964.205727083721;4399.802008909543;4971.776270067856;4974.751262436864;4994.150994330972;5005.199168133154;5375.650582712111;5556.555475561945;5607.52336051432;5643.802466913638;5649.37856835756;6714.515629217123;6739;6754.696038678271;6766.391024807693;6767.492438067165;1501.6621260216364;1698.3716025070803;1700.676871394456;1712.6574685063038;1719.5701074731317;1145.410113791398;1152.6005425752999;1157.8784227655974;1161.5085641299534;1179.4161889864572;5309.495597918191;5377.542908852792;5821.883562328814;6212.285587157445;6251.624902505864;5796.826095217066;6486.735086658056;6934.791956241321;6969.930300697029;6984;4914.5576898078625;5638.830835074954;6234.688265586702;6265.248170219512;6273.309935907047;3052.6947305269296;3177.5710279112486;3550.875229797761;3567.464880267981;3638.7270954678506;6366.522510811615;6387.968060159762;6500.674966251669;6982.860342793116;7180.389666878269;5760.711964401763;6045;6395.456386207132;7258;7291.8906216406795;5814.825555233349;6181.196444462281;6487.578307410004;7072.434205263567;7124.430045596444;6617.43751781104;6665.966670166618;6896.689628970479;7036.261192574911;7049.647517623996;5993.790217342372;6855.657217139223;6876.621785801829;6918.169819621678;6935.202451718117;5766.481016708349;6858.587668478456;7129.429645628234;7132.928670713434;7134;4405.361222622638;4454.688171827941;4459.420275364311;4480.215962206666;4481.574250446202;6078.848028799315;6517.283098859027;6783.864322713617;6892.655367231518;6926.93073069283;5597.664140151441;6642.6014439133805;6698.531102822755;6723.327667233238;6732.865342693217;5823.5923485355615;6673.232578253563;6699.732010719516;6710.295418980937;6715.630640314635;6346.365363463617;6557.311482294481;6558.573692709959;6583.407493325623;6593.450539123398;5025.386798864643;6414.166158399378;6447.387498187664;6656.101426307387;6668.066050937572;5815.621984570989;5905.232319798399;6284.694983936019;6517;6528.738850445929 04:51:26 INFO - PID 1654 | |5;yui.html;639.284001917852;692.9203141638714;711.0933559711364;716.8745469542832;737.9446541509388;12844.871551284485;16371.75442368364;16574.50276491704;16753.99476031436;16903.323867045336;14898.776518352233;15215.619609509768;15230.695386092271;15323;15444.459443919437;979.4221409368471;1004.9598016079348;1016.6492560066765;1017.1506791828832;1020.2857999400412;995.7311525888006;1022.6420752736557;1029.0532709906904;1041.536516250269;1047.8533005379254;1089.536946797608;1089.84742136101;1091.1761619976946;1091.2034215023039;1095.583678202282;1066.5733706517378;1078.7680648660576;1083.3716444462232;1083.5828206140613;1084.5390708948705;673.3804899492429;785.3010820369875;799.5242830515833;802.9718959836378;807.0678366486717;16675.91662041682;16983.23575439108;17015.659686806193;17110.058946757923;17458.30166793327;14966.551003469913;15047.172405517693;15100.848991510054;15232.390704371812;16027.118508482028;11583.76832463346;11657.242279251821;11704.47329870158;11828.704282392922;12274.938625306906;3017.09487153853;3025.13783571681;3089.675584063686;3129.874805007797;3192.3296107817387;122394.38802806108;125222;127571;128887.35556322252;130623;9985.251106167067;10173.237007224488;11179;11466.770664586662;11730.94134529339;25235.369115772253;25322.366940826625;25481.745182548308;25563.61654575183;25760.48479030409;7935.166807485246;8005.239502247394;8069.919300807034;8099.433039687283;8253.876191857127;4283;4322.762248076386;4325.480942286883;4360.171567402247;4430.113977204572;4228.619424251832;4285.3786201000685;4333.025069359432;4340.544242854518;4365.236083685342;658.713459645056;749.9212582678849;752.7102065704743;758.7382353088176;774.8992630958052;527.7229454536399;545.2693390856272;564.8503146666137;590.3771521045253;592.5407808948099;9638.9036109638;9776.413415195111;10262.743431414274;10297.9485102574;10539.209559283085;542.7245971965928;560.71964017991;576.0638961687258;585.3385674188225;612.7059011674421;4684.156851766715;4771.355866957986;4785.425748910084;4789.95210047902;4809.687370320918;109734;110078.44960775145;110612;111231.44384278027;111782;84983;85992.57003715067;86068;87425.1257487417;87484;84156;84552;85733.57133214294;86647.56676216704;87219.56390218009;9590.66432674853;9689.9031009689;9714.3199976001;9719.46542940145;9777.85333219988;40374;41251.58748412477;41517.37723934204;41745.94683770897;42058;41848.79075604602;53376;53906.46093539015;54288;54767.72616136894;11696.94151529271;11738.647840564796;11830.40847957616;11967.281963082243;12285.324307163191;12474.128880667973;12707.301098439675;13041.478340866639;13361.398737056661;14407.543299795503;14133.929330353694;14247.928760356132;14256.572302830931;14622.122672639676;14767.187804670846;14089.418777943369;14164.291785410895;14281;14292.499762508678;15045.924770376078;13774.793378099537;13820.37808298649;13913.590227252296;13982.650433739238;14938.551843444715;8920.598573064357;10300.948495257475;10575.206859485415;10580.259381843198;11017.11863050938;9347.098909754242;10017.949910250401;11223.887761122285;11345.659630211107;11635.41822908868 04:51:26 INFO - PID 1654 | __end_tp_report 04:51:26 INFO - PID 1654 | __start_cc_report 04:51:26 INFO - PID 1654 | _x_x_mozilla_cycle_collect,427 04:51:26 INFO - PID 1654 | __end_cc_report 04:51:26 INFO - PID 1654 | __startTimestamp1491220286195__endTimestamp 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | ------- Summary: start ------- 04:51:26 INFO - PID 1654 | Number of tests: 6 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | [#0] dojo.html Cycles:165 Average:6102.04 Median:6308.65 stddev:728.71 (11.6%) stddev-sans-first:702.51 04:51:26 INFO - PID 1654 | Values: 3532.8 3555.3 3581.7 3598.8 3610.1 6133.2 6186.4 6193.7 6194.7 6239.3 6156.4 6162.9 6164.4 6233.4 6241.6 5429.1 5473.3 5532.5 5558.4 5576.5 5423.3 5471.4 5564.9 5576.5 5579.9 5395.0 5472.5 5502.8 5516.4 5555.2 5460.1 5479.3 5499.6 5525.3 5537.3 5406.6 5423.0 5424.3 5433.6 5467.9 6063.4 6101.5 6145.8 6147.8 6187.2 6666.7 6678.9 6711.6 6720.9 6734.8 5723.8 6118.5 6801.9 6809.7 6875.0 6162.8 6192.8 6284.9 6328.0 6346.6 5830.9 6817.7 6837.9 6900.1 6922.8 6308.8 6327.1 6435.1 6536.5 6591.4 6710.7 6763.9 6765.9 6785.0 6800.1 5445.0 6376.1 6671.7 6676.8 6677.5 6448.7 6466.6 6604.5 6635.2 6700.3 4581.5 4666.0 5293.2 5302.9 5345.2 4738.3 4754.0 4769.0 4775.9 4794.6 6111.7 6209.0 6217.3 6223.1 6242.0 6828.1 6848.5 6852.1 6860.7 6866.8 5286.7 6141.3 6306.6 6308.7 6328.4 5757.8 5829.3 5840.8 5845.6 6020.3 6644.8 6662.4 6733.2 6779.0 6792.7 6773.4 6784.4 6787.6 6788.7 6810.3 5760.6 6751.6 6782.6 6835.0 6836.9 5482.3 6358.0 6467.4 6676.3 6679.7 6798.7 6800.4 6809.4 6811.4 6812.8 6327.2 6429.7 6471.7 6521.3 6577.1 6513.6 6556.4 6615.1 6627.6 6635.9 5234.5 5319.3 5625.2 6329.9 6372.0 5741.8 6291.5 6515.9 6563.1 6567.0 6373.2 6379.2 6379.3 6395.9 6400.1 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | [#1] ext.html Cycles:180 Average:52379.74 Median:36963.17 stddev:102370.88 (277.0%) stddev-sans-first:102584.69 04:51:26 INFO - PID 1654 | Values: 760.2 779.4 838.1 1057.0 1279.2 39864.4 40927.0 40957.8 40978.4 40990.6 40070.8 40255.8 40472.0 40526.2 40560.8 7726.2 8080.8 8183.0 8371.9 8546.2 8658.3 8799.3 8811.4 8851.2 8854.3 8752.0 8821.6 8832.9 8838.7 8842.0 8751.7 8783.9 8803.0 8831.7 8833.7 8459.6 8482.5 8537.0 8538.1 8550.7 39836.4 39899.8 40175.2 40262.8 40351.8 3028.8 3057.0 3063.1 3066.2 3067.1 28659.4 28698.3 28771.7 28957.0 29786.9 2796.2 2798.3 2806.5 2807.6 2819.4 278754.0 284950.0 294800.0 335482.3 337169.0 49155.5 49468.8 49474.8 49528.0 49556.0 51433.1 51749.7 51839.0 51890.0 51897.7 14437.4 14594.9 14603.8 14615.0 14619.2 12008.7 12066.0 12083.2 12095.3 12100.2 13776.9 13894.4 13996.2 14053.9 14076.2 6043.6 6059.7 6061.5 6071.2 6078.1 858.7 986.7 988.6 992.9 1029.9 28524.9 29649.0 29726.3 30057.8 30993.8 1052.3 1055.4 1089.7 1096.4 1100.8 10897.4 11869.5 11969.3 12314.9 12415.7 403065.0 451108.0 452149.0 452774.0 453636.7 55005.2 55121.0 55360.0 55909.0 55987.4 1329.6 1417.4 1471.0 1473.6 1475.5 18992.4 19907.3 21662.0 23369.4 24089.4 31962.0 38445.8 38590.6 38786.4 38801.4 395241.0 396177.0 397235.0 397633.0 398058.0 34096.7 35499.5 36197.6 36248.6 36344.0 43268.6 43609.3 44287.1 44867.0 44976.8 30552.7 30645.0 31498.4 31671.4 31868.7 28414.6 30787.7 31257.1 31652.8 31783.4 36413.6 36931.1 36995.3 37344.0 37439.4 25105.1 25564.9 30236.7 30475.1 31530.8 24309.3 24822.8 24885.8 25370.2 25446.7 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | [#2] jquery.html Cycles:180 Average:43567.68 Median:12268.09 stddev:119576.86 (974.7%) stddev-sans-first:119868.37 04:51:26 INFO - PID 1654 | Values: 395.8 415.5 415.5 425.9 439.9 17648.9 20918.6 21123.2 22155.7 22309.8 22789.8 22905.2 23395.9 23409.8 23600.6 6074.1 6411.1 6412.0 6445.0 6454.2 6029.1 6241.8 6272.4 6341.3 6348.0 5441.3 6043.8 6271.2 6296.6 6318.1 5612.7 6117.9 6183.4 6370.7 6373.8 5374.2 5539.8 5629.8 5638.4 5651.9 26997.9 27607.0 29735.7 29886.3 30853.7 2118.9 2121.9 2153.7 2203.1 2226.4 16179.4 17720.6 17803.7 18254.2 18307.4 1948.6 2029.4 2034.4 2040.4 2053.8 163107.2 176399.0 177152.1 178515.2 181199.0 21518.6 26092.0 26439.9 26758.5 26935.3 42400.2 42687.0 42693.0 43024.8 43302.6 9402.0 11409.4 11453.9 11530.1 11575.9 8869.0 8882.3 8898.8 8912.1 8998.5 10241.9 11322.7 11512.4 11752.9 11822.6 4120.5 4694.0 4698.0 4701.5 4722.7 824.7 885.9 919.5 962.7 995.8 20834.9 21278.6 21393.9 21425.4 21513.5 871.9 898.4 971.4 999.6 1011.8 10932.1 10995.3 11166.4 11202.4 11208.7 695373.0 701855.0 713423.0 717461.0 724452.0 146477.0 154011.5 160463.0 164943.0 167651.0 1160.1 1169.2 1208.3 1209.9 1210.2 20857.5 22363.8 22443.3 22537.0 22681.8 51234.7 63248.0 63366.7 63460.0 63502.7 90016.5 90259.0 90595.5 90621.0 93110.5 12078.5 12183.5 12524.9 12871.7 12906.8 13633.9 13819.4 13937.5 13938.7 14126.4 10085.3 10756.4 10937.2 11785.8 11852.5 10059.3 10911.0 11002.2 11156.8 11176.8 11534.2 11570.7 11711.8 12027.6 12137.4 12423.9 12516.3 12853.3 12903.4 13178.1 10877.8 11118.2 11634.7 11991.2 12035.5 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | [#3] mootools.html Cycles:180 Average:6761.10 Median:2470.06 stddev:4208.15 (170.4%) stddev-sans-first:4199.43 04:51:26 INFO - PID 1654 | Values: 1230.8 1332.7 1422.2 1426.3 1441.4 10755.8 11137.7 11230.0 11252.2 11257.4 11072.6 11168.0 11215.4 11225.4 11225.7 2450.4 2477.1 2482.1 2482.5 2483.9 2363.5 2380.3 2381.1 2385.1 2395.1 2330.2 2357.0 2368.8 2452.9 2463.0 2270.5 2400.5 2407.4 2410.1 2433.3 2056.9 2137.0 2355.7 2395.6 2409.6 11075.3 11095.9 11161.3 11178.7 11206.9 5796.9 6300.1 6304.7 6325.4 6331.5 3828.5 3903.8 3907.7 3928.5 3997.2 1212.2 1534.4 1575.6 1604.3 1635.5 12891.9 14201.2 15197.4 15206.8 15227.1 5221.2 5446.8 5479.7 5486.1 5550.5 11409.0 11470.4 11497.1 11507.2 11515.9 6241.8 6305.7 6320.7 6321.2 6332.6 5595.6 5761.0 5763.1 5841.9 5979.6 4083.5 4208.8 4259.6 4262.3 4305.7 1211.8 1216.4 1225.1 1227.2 1228.6 626.6 746.7 769.2 771.0 781.4 5004.5 5701.3 5801.4 6007.4 6051.3 563.8 567.9 589.1 596.1 599.2 3739.5 4044.6 4120.6 4250.3 4325.5 13053.0 14210.4 14218.6 14243.0 14272.9 13703.3 13783.0 14007.5 14140.4 14223.6 10188.0 10254.9 10267.9 10313.5 10367.8 6460.6 6474.7 6487.9 6535.6 6648.1 11217.7 12336.8 12353.4 12629.7 12653.1 12834.4 12837.8 12999.0 13090.3 13113.1 8182.7 8272.7 8293.7 8392.0 8402.6 10075.8 10111.3 10154.3 10233.9 10237.9 7332.7 8408.9 8644.7 8670.7 8724.1 8417.0 8535.1 8546.3 8615.4 8660.5 6944.8 7728.3 7812.4 7939.6 7941.6 5276.8 5867.9 5969.7 6036.2 6076.0 5844.6 5864.6 6051.6 6089.8 6236.1 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | [#4] prototype.html Cycles:180 Average:5402.23 Median:5923.86 stddev:1646.31 (27.8%) stddev-sans-first:1606.73 04:51:26 INFO - PID 1654 | Values: 353.8 381.3 383.1 399.0 403.7 6163.7 6354.9 6418.2 6457.4 6507.5 6094.7 6273.0 6290.4 6295.8 6311.9 3760.0 4177.9 4802.5 4808.5 4820.6 3971.5 4591.0 4733.5 4734.4 4815.3 4331.4 4551.5 4708.6 4712.1 4727.0 4732.3 4745.4 4754.1 4762.8 4763.9 4007.0 4162.5 4200.0 4211.0 4220.3 4956.8 5804.2 5942.5 6084.5 6176.6 5615.7 5630.7 5643.5 5646.4 5649.5 6458.3 6688.8 6748.8 6773.3 6796.2 4162.8 4203.4 4633.6 4792.0 4800.5 6086.1 6206.4 6797.4 6970.7 7187.7 4084.2 4623.5 4859.3 4894.6 4964.2 4399.8 4971.8 4974.8 4994.2 5005.2 5375.7 5556.6 5607.5 5643.8 5649.4 6714.5 6739.0 6754.7 6766.4 6767.5 1501.7 1698.4 1700.7 1712.7 1719.6 1145.4 1152.6 1157.9 1161.5 1179.4 5309.5 5377.5 5821.9 6212.3 6251.6 5796.8 6486.7 6934.8 6969.9 6984.0 4914.6 5638.8 6234.7 6265.2 6273.3 3052.7 3177.6 3550.9 3567.5 3638.7 6366.5 6388.0 6500.7 6982.9 7180.4 5760.7 6045.0 6395.5 7258.0 7291.9 5814.8 6181.2 6487.6 7072.4 7124.4 6617.4 6666.0 6896.7 7036.3 7049.6 5993.8 6855.7 6876.6 6918.2 6935.2 5766.5 6858.6 7129.4 7132.9 7134.0 4405.4 4454.7 4459.4 4480.2 4481.6 6078.8 6517.3 6783.9 6892.7 6926.9 5597.7 6642.6 6698.5 6723.3 6732.9 5823.6 6673.2 6699.7 6710.3 6715.6 6346.4 6557.3 6558.6 6583.4 6593.5 5025.4 6414.2 6447.4 6656.1 6668.1 5815.6 5905.2 6284.7 6517.0 6528.7 04:51:26 INFO - PID 1654 | 04:51:26 INFO - PID 1654 | [#5] yui.html Cycles:180 Average:20978.84 Median:17062.86 stddev:31332.31 (183.6%) stddev-sans-first:31382.98 04:51:26 INFO - PID 1654 | Values: 639.3 692.9 711.1 716.9 737.9 12844.9 16371.8 16574.5 16754.0 16903.3 14898.8 15215.6 15230.7 15323.0 15444.5 979.4 1005.0 1016.6 1017.2 1020.3 995.7 1022.6 1029.1 1041.5 1047.9 1089.5 1089.8 1091.2 1091.2 1095.6 1066.6 1078.8 1083.4 1083.6 1084.5 673.4 785.3 799.5 803.0 807.1 16675.9 16983.2 17015.7 17110.1 17458.3 14966.6 15047.2 15100.8 15232.4 16027.1 11583.8 11657.2 11704.5 11828.7 12274.9 3017.1 3025.1 3089.7 3129.9 3192.3 122394.4 125222.0 127571.0 128887.4 130623.0 9985.3 10173.2 11179.0 11466.8 11730.9 25235.4 25322.4 25481.7 25563.6 25760.5 7935.2 8005.2 8069.9 8099.4 8253.9 4283.0 4322.8 4325.5 4360.2 4430.1 4228.6 4285.4 4333.0 4340.5 4365.2 658.7 749.9 752.7 758.7 774.9 527.7 545.3 564.9 590.4 592.5 9638.9 9776.4 10262.7 10297.9 10539.2 542.7 560.7 576.1 585.3 612.7 4684.2 4771.4 4785.4 4790.0 4809.7 109734.0 110078.4 110612.0 111231.4 111782.0 84983.0 85992.6 86068.0 87425.1 87484.0 84156.0 84552.0 85733.6 86647.6 87219.6 9590.7 9689.9 9714.3 9719.5 9777.9 40374.0 41251.6 41517.4 41745.9 42058.0 41848.8 53376.0 53906.5 54288.0 54767.7 11696.9 11738.6 11830.4 11967.3 12285.3 12474.1 12707.3 13041.5 13361.4 14407.5 14133.9 14247.9 14256.6 14622.1 14767.2 14089.4 14164.3 14281.0 14292.5 15045.9 13774.8 13820.4 13913.6 13982.7 14938.6 8920.6 10300.9 10575.2 10580.3 11017.1 9347.1 10017.9 11223.9 11345.7 11635.4 04:51:26 INFO - PID 1654 | -------- Summary: end -------- 04:51:26 INFO - PID 1654 | 04:51:26 INFO - TEST-INFO | 1654: exit 0 04:51:26 INFO - TEST-OK | dromaeo_css | took 1116295ms 04:51:26 INFO - TEST-START | kraken 04:51:26 INFO - operating with platform_type : mac_ 04:51:26 INFO - Initialising browser for kraken test... 04:51:26 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpFXcc9J/profile http://localhost:49250/getInfo.html) 04:51:29 INFO - PID 1661 | 2017-04-03 04:51:29.615 plugin-container[1662:10538] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 04:51:29 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:29 INFO - PID 1661 | 2017-04-03 04:51:29.617 plugin-container[1662:10538] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 04:51:29 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:29 INFO - PID 1661 | 2017-04-03 04:51:29.617 plugin-container[1662:10538] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:51:29 INFO - PID 1661 | __metrics Screen width/height:1600/1200 04:51:29 INFO - PID 1661 | colorDepth:24 04:51:29 INFO - PID 1661 | Browser inner width/height: 1024/689 04:51:29 INFO - PID 1661 | __metrics 04:51:29 ERROR - PID 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:51:30 INFO - TEST-INFO | 1661: exit 0 04:51:30 INFO - Browser initialized. 04:51:30 INFO - Running cycle 1/1 for kraken test... 04:51:30 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpFXcc9J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:33 INFO - PID 1663 | 2017-04-03 04:51:32.997 plugin-container[1664:10663] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 04:51:33 INFO - PID 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:33 INFO - PID 1663 | 2017-04-03 04:51:32.997 plugin-container[1664:10663] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9023, name = 'com.apple.CFPasteboardClient' 04:51:33 INFO - PID 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:33 INFO - PID 1663 | 2017-04-03 04:51:32.997 plugin-container[1664:10663] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:51:42 INFO - PID 1663 | RSS: Main: 229781504 04:51:42 INFO - PID 1663 | 04:51:45 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:46 INFO - PID 1663 | RSS: Main: 243544064 04:51:46 INFO - PID 1663 | 04:51:49 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 04:51:49 INFO - PID 1663 | RSS: Main: 252661760 04:51:49 INFO - PID 1663 | 04:51:53 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 04:51:54 INFO - PID 1663 | RSS: Main: 254361600 04:51:54 INFO - PID 1663 | 04:51:56 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 04:51:56 INFO - PID 1663 | RSS: Main: 255717376 04:51:56 INFO - PID 1663 | 04:51:58 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:59 INFO - PID 1663 | RSS: Main: 255975424 04:51:59 INFO - PID 1663 | 04:52:02 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:03 INFO - PID 1663 | RSS: Main: 261709824 04:52:03 INFO - PID 1663 | 04:52:06 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:07 INFO - PID 1663 | RSS: Main: 263438336 04:52:07 INFO - PID 1663 | 04:52:10 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 04:52:11 INFO - PID 1663 | RSS: Main: 263405568 04:52:11 INFO - PID 1663 | 04:52:12 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:13 INFO - PID 1663 | RSS: Main: 262631424 04:52:13 INFO - PID 1663 | 04:52:15 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:15 INFO - PID 1663 | RSS: Main: 262615040 04:52:15 INFO - PID 1663 | 04:52:17 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:18 INFO - PID 1663 | RSS: Main: 262615040 04:52:18 INFO - PID 1663 | 04:52:21 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:22 INFO - PID 1663 | RSS: Main: 263241728 04:52:22 INFO - PID 1663 | 04:52:25 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:26 INFO - PID 1663 | RSS: Main: 268267520 04:52:26 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 04:52:28 INFO - PID 1663 | RSS: Main: 270999552 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | __start_tp_report 04:52:28 INFO - PID 1663 | _x_x_mozilla_page_load 04:52:28 INFO - PID 1663 | _x_x_mozilla_page_load_details 04:52:28 INFO - PID 1663 | |i|pagename|runs| 04:52:28 INFO - PID 1663 | |0;ai-astar;109;123;121;121;125;121;122;144;124;150 04:52:28 INFO - PID 1663 | |1;audio-beat-detection;151;116;134;195;104;141;155;102;175;156 04:52:28 INFO - PID 1663 | |2;audio-dft;223;227;227;221;253;303;291;215;215;229 04:52:28 INFO - PID 1663 | |3;audio-fft;85;59;78;118;87;89;61;58;73;57 04:52:28 INFO - PID 1663 | |4;audio-oscillator;87;73;88;73;72;75;85;74;72;88 04:52:28 INFO - PID 1663 | |5;imaging-gaussian-blur;117;91;97;96;141;139;92;92;91;90 04:52:28 INFO - PID 1663 | |6;imaging-darkroom;101;100;99;101;99;100;101;99;101;100 04:52:28 INFO - PID 1663 | |7;imaging-desaturate;160;101;124;148;100;128;101;101;99;101 04:52:28 INFO - PID 1663 | |8;json-parse-financial;51;53;52;51;53;53;53;52;53;53 04:52:28 INFO - PID 1663 | |9;json-stringify-tinderbox;59;66;58;63;71;65;58;60;59;57 04:52:28 INFO - PID 1663 | |10;stanford-crypto-aes;88;92;106;124;114;95;87;87;87;86 04:52:28 INFO - PID 1663 | |11;stanford-crypto-ccm;153;153;145;162;175;169;169;166;212;170 04:52:28 INFO - PID 1663 | |12;stanford-crypto-pbkdf2;226;204;215;252;220;198;201;194;191;250 04:52:28 INFO - PID 1663 | |13;stanford-crypto-sha256-iterative;72;73;72;72;74;76;93;88;71;72 04:52:28 INFO - PID 1663 | __end_tp_report 04:52:28 INFO - PID 1663 | __start_cc_report 04:52:28 INFO - PID 1663 | _x_x_mozilla_cycle_collect,1021 04:52:28 INFO - PID 1663 | __end_cc_report 04:52:28 INFO - PID 1663 | __startTimestamp1491220348650__endTimestamp 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | ------- Summary: start ------- 04:52:28 INFO - PID 1663 | Number of tests: 14 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#0] ai-astar Cycles:10 Average:126.00 Median:123.50 stddev:11.99 (9.7%) stddev-sans-first:11.03 04:52:28 INFO - PID 1663 | Values: 109.0 123.0 121.0 121.0 125.0 121.0 122.0 144.0 124.0 150.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:153.00 stddev:30.04 (19.6%) stddev-sans-first:31.72 04:52:28 INFO - PID 1663 | Values: 151.0 116.0 134.0 195.0 104.0 141.0 155.0 102.0 175.0 156.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#2] audio-dft Cycles:10 Average:240.40 Median:228.00 stddev:31.79 (13.9%) stddev-sans-first:33.09 04:52:28 INFO - PID 1663 | Values: 223.0 227.0 227.0 221.0 253.0 303.0 291.0 215.0 215.0 229.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#3] audio-fft Cycles:10 Average:76.50 Median:75.50 stddev:19.28 (25.5%) stddev-sans-first:20.20 04:52:28 INFO - PID 1663 | Values: 85.0 59.0 78.0 118.0 87.0 89.0 61.0 58.0 73.0 57.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:80.00 stddev:7.24 (9.1%) stddev-sans-first:7.03 04:52:28 INFO - PID 1663 | Values: 87.0 73.0 88.0 73.0 72.0 75.0 85.0 74.0 72.0 88.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:104.60 Median:91.50 stddev:20.26 (22.1%) stddev-sans-first:20.99 04:52:28 INFO - PID 1663 | Values: 117.0 91.0 97.0 96.0 141.0 139.0 92.0 92.0 91.0 90.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:101.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 04:52:28 INFO - PID 1663 | Values: 101.0 100.0 99.0 101.0 99.0 100.0 101.0 99.0 101.0 100.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#7] imaging-desaturate Cycles:10 Average:116.30 Median:126.00 stddev:22.64 (18.0%) stddev-sans-first:17.64 04:52:28 INFO - PID 1663 | Values: 160.0 101.0 124.0 148.0 100.0 128.0 101.0 101.0 99.0 101.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.73 04:52:28 INFO - PID 1663 | Values: 51.0 53.0 52.0 51.0 53.0 53.0 53.0 52.0 53.0 53.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:4.53 (7.4%) stddev-sans-first:4.70 04:52:28 INFO - PID 1663 | Values: 59.0 66.0 58.0 63.0 71.0 65.0 58.0 60.0 59.0 57.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:87.00 stddev:13.45 (15.5%) stddev-sans-first:13.90 04:52:28 INFO - PID 1663 | Values: 88.0 92.0 106.0 124.0 114.0 95.0 87.0 87.0 87.0 86.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:167.40 Median:169.00 stddev:18.28 (10.8%) stddev-sans-first:18.63 04:52:28 INFO - PID 1663 | Values: 153.0 153.0 145.0 162.0 175.0 169.0 169.0 166.0 212.0 170.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.10 Median:217.50 stddev:22.02 (10.1%) stddev-sans-first:23.00 04:52:28 INFO - PID 1663 | Values: 226.0 204.0 215.0 252.0 220.0 198.0 201.0 194.0 191.0 250.0 04:52:28 INFO - PID 1663 | 04:52:28 INFO - PID 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:73.50 stddev:7.70 (10.5%) stddev-sans-first:8.01 04:52:28 INFO - PID 1663 | Values: 72.0 73.0 72.0 72.0 74.0 76.0 93.0 88.0 71.0 72.0 04:52:28 INFO - PID 1663 | -------- Summary: end -------- 04:52:28 INFO - PID 1663 | 04:52:29 INFO - TEST-INFO | 1663: exit 0 04:52:29 INFO - TEST-OK | kraken | took 62944ms 04:52:29 INFO - SUITE-END | took 1179s 04:52:29 INFO - Completed test suite (00:19:39) 04:52:29 INFO - javascript benchmark 04:52:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7927.449596590056, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3532.7703699259546, 3555.253396786675, 3581.6597423244816, 3598.784072955623, 3610.115521697184, 6133.151048553284, 6186.381361863817, 6193.659348735818, 6194.7212375443105, 6239.34486878878, 6156.445919867211, 6162.907556386658, 6164.352742961992, 6233.407826256498, 6241.625502469855, 5429.077056900317, 5473.28847249857, 5532.529734972532, 5558.44415558443, 5576.470235327637, 5423.3491980962335, 5471.398146203935, 5564.944350556483, 5576.525995290405, 5579.944200557983, 5395.0, 5472.534834539069, 5502.8349149525575, 5516.365617953907, 5555.194496797962, 5460.099083651193, 5479.2602998595075, 5499.587530935156, 5525.309336332958, 5537.307836520435, 5406.648567843077, 5422.9728851355885, 5424.321959755031, 5433.646812957145, 5467.875978903653, 6063.393660633946, 6101.481374083208, 6145.78489752861, 6147.770445910835, 6187.226596675416, 6666.699998500079, 6678.933210667879, 6711.597304161717, 6720.932790672079, 6734.8316292092595, 5723.826615543803, 6118.4799292060225, 6801.863962720768, 6809.727610895558, 6874.9656251718925, 6162.815115546541, 6192.783252586138, 6284.87430251397, 6327.968360158262, 6346.619202847844, 5830.941690583125, 6817.659117044128, 6837.863242735118, 6900.137482814648, 6922.757703480354, 6308.810735677937, 6327.050942358591, 6435.06691529735, 6536.509761767887, 6591.406773390322, 6710.664466776641, 6763.864722705617, 6765.864682706417, 6785.0, 6800.149981252343, 5444.992676354887, 6376.107344971708, 6671.699773510204, 6676.766313179112, 6677.465802735769, 6448.677566121675, 6466.644334561644, 6604.471642268607, 6635.2037755469655, 6700.262971073178, 4581.496035436099, 4666.0, 5293.206019097166, 5302.946970530245, 5345.198220266913, 4738.3129446230105, 4754.02542478791, 4769.0, 4775.928361074587, 4794.640401969797, 6111.682900513584, 6209.0, 6217.347178546188, 6223.1287619733275, 6241.96879015602, 6828.146481689789, 6848.486363522756, 6852.109225800614, 6860.725570977205, 6866.759663411856, 5286.709230992333, 6141.263048434216, 6306.558540902093, 6308.653024083627, 6328.430441260309, 5757.798477053283, 5829.300483941955, 5840.766369345179, 5845.620034697731, 6020.277566692025, 6644.767433139817, 6662.367075127855, 6733.158355205599, 6778.966105169443, 6792.728290868507, 6773.356531129732, 6784.3894049535775, 6787.626680532618, 6788.728450862108, 6810.250872404131, 5760.6255593386295, 6751.56114852533, 6782.641524430172, 6835.0, 6836.931630683828, 5482.342118945752, 6357.96821015892, 6467.385598368148, 6676.332366763285, 6679.666016699242, 6798.694058767466, 6800.421964132906, 6809.353111454404, 6811.421029212374, 6812.795616131524, 6327.2407311121115, 6429.7428102875365, 6471.708773105127, 6521.347865213441, 6577.079208910852, 6513.576617519846, 6556.442702370352, 6615.106960560262, 6627.635480048643, 6635.9004614929845, 5234.502722241381, 5319.335083114611, 5625.240592519957, 6329.8734025320155, 6372.0, 5741.794223213005, 6291.496680265659, 6515.869682606416, 6563.0811686362995, 6567.0, 6373.235211774617, 6379.170707807955, 6379.298277189599, 6395.936040639534, 6400.135981642418], "value": 6055.833049705604, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.2017881224713, 779.3764988009592, 838.0990435282073, 1056.96300629478, 1279.2324605236859, 39864.402033969476, 40927.0, 40957.771266861964, 40978.38532422016, 40990.59009409909, 40070.79787606376, 40255.798721006424, 40472.0, 40526.18947621046, 40560.79719601405, 7726.227377262257, 8080.757577272691, 8183.018037835468, 8371.874421883645, 8546.188112129337, 8658.307335413183, 8799.29605631548, 8811.427257228292, 8851.203391694778, 8854.291656667483, 8751.95624021879, 8821.60302786373, 8832.851729275217, 8838.73483795484, 8842.0, 8751.693690720826, 8783.902012248469, 8802.955985220065, 8831.69089081879, 8833.690820821304, 8459.619317130682, 8482.53346065966, 8536.957315213383, 8538.103499132625, 8550.74347769568, 39836.402453963216, 39899.80300590987, 40175.19649607021, 40262.798686006674, 40351.798241008604, 3028.7543106656544, 3057.021753039028, 3063.0657649416917, 3066.2027872753247, 3067.079876037202, 28659.42681146386, 28698.282542936384, 28771.71228287732, 28956.986505472418, 29786.851065744748, 2796.175128337125, 2798.3423895384567, 2806.480801051812, 2807.6490438695164, 2819.3797364579964, 278754.0, 284950.0, 294800.0, 335482.32258838793, 337169.0, 49155.508444915096, 49468.75265623721, 49474.75262623664, 49528.0, 49556.0, 51433.14251431158, 51749.741251294254, 51839.0, 51890.0, 51897.740511297205, 14437.422503099968, 14594.927025364805, 14603.78094328586, 14615.0, 14619.195944222956, 12008.699782505508, 12066.0, 12083.214591051554, 12095.27428354284, 12100.152989290842, 13776.93111534456, 13894.444222230997, 13996.230207338695, 14053.929730351283, 14076.225807580682, 6043.637381757108, 6059.7273122709585, 6061.515078793774, 6071.241094863142, 6078.149059131725, 858.6947839284253, 986.7237173591406, 988.5897352598591, 992.9156021738089, 1029.8712660917386, 28524.857375713404, 29648.962286319875, 29726.25684357908, 30057.849710751307, 30993.8450307747, 1052.3002203534718, 1055.3667799320347, 1089.6730980705756, 1096.3531516405199, 1100.7523307255804, 10897.400642964712, 11869.525218991317, 11969.264456653736, 12314.938425307995, 12415.689607759878, 403065.0, 451108.0, 452149.0, 452774.0, 453636.7318163454, 55005.174922376194, 55121.0, 55360.0, 55909.0, 55987.44012559904, 1329.5944736855158, 1417.4471955937192, 1470.9705805883823, 1473.5800296915327, 1475.4614565683662, 18992.43022709321, 19907.303244386956, 21662.025208865325, 23369.41576460602, 24089.397765056015, 31962.0, 38445.807770960964, 38590.614093858705, 38786.41820372753, 38801.447942082, 395241.0, 396177.0, 397235.0, 397633.0, 398058.0, 34096.69211195937, 35499.467507987916, 36197.63802361942, 36248.637513624526, 36344.00215976293, 43268.56731432645, 43609.34585981276, 44287.11425771531, 44867.0, 44976.77511612421, 30552.694473054984, 30645.0, 31498.37003259968, 31671.366572668878, 31868.68131318657, 28414.57378139371, 30787.692123078483, 31257.062288131394, 31652.841735791175, 31783.364332713678, 36413.635863642085, 36931.07672308106, 36995.26009479849, 37344.0, 37439.43840842444, 25105.121320753686, 25564.872175639004, 30236.69763302339, 30475.085747427613, 31530.842345788125, 24309.270721878373, 24822.751772482043, 24885.751142488345, 25370.238892832505, 25446.745532545177], "value": 17964.46585947095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.7961649750379, 415.50347334934764, 415.51799912101967, 425.8743670617168, 439.94500687414074, 17648.85282456641, 20918.581628367425, 21123.15507379705, 22155.667664985038, 22309.776902230973, 22789.772102278974, 22905.198318058872, 23395.88302058487, 23409.82950852459, 23600.64599031016, 6074.058520929263, 6411.1024456576115, 6412.0, 6444.967775161118, 6454.225492940854, 6029.1257767623665, 6241.812745617616, 6272.372762723737, 6341.334159913212, 6348.0477928310665, 5441.347038355403, 6043.8186854394435, 6271.247450305969, 6296.590721603104, 6318.083877837711, 5612.747426365823, 6117.898778219918, 6183.381661833803, 6370.713317900682, 6373.757117362116, 5374.220737992969, 5539.833804985857, 5629.831105066854, 5638.379778224433, 5651.9152212716845, 26997.920083196845, 27607.0, 29735.70264297351, 29886.252843678863, 30853.691463085306, 2118.872867627932, 2121.8726876387313, 2153.720016397874, 2203.0857194264363, 2226.398872304485, 16179.35282588695, 17720.645587088315, 17803.73294400585, 18254.17856196461, 18307.35924242645, 1948.6395016921915, 2029.3708950225478, 2034.4201902457728, 2040.357287454462, 2053.784352642966, 163107.1844640781, 176399.0, 177152.114239428, 178515.21484784986, 181199.0, 21518.56962860734, 26091.95632174692, 26439.867800661257, 26758.464830703277, 26935.326616834736, 42400.15199695989, 42687.0, 42693.0, 43024.78487607542, 43302.56697433048, 9401.952990235006, 11409.42952852354, 11453.942730286295, 11530.135239857043, 11575.942120289345, 8869.0, 8882.333824963154, 8898.777530561658, 8912.064233255414, 8998.460092394478, 10241.948790256001, 11322.69788974262, 11512.445819814218, 11752.882471175179, 11822.645320640395, 4120.546739858613, 4694.0, 4697.976510117496, 4701.529847015271, 4722.693024953367, 824.6704799801045, 885.9468431894107, 919.5494207838245, 962.7400601837604, 995.7759504111517, 20834.89582552108, 21278.574428511343, 21393.89303053506, 21425.357239282846, 21513.462163446038, 871.8622198031503, 898.4294972692256, 971.4171497101682, 999.6101520407047, 1011.7824667696333, 10932.067932067932, 10995.285306455055, 11166.441677916235, 11202.38386888729, 11208.66374008781, 695373.0, 701855.0, 713423.0, 717461.0, 724452.0, 146477.0, 154011.45988540194, 160463.0, 164943.0, 167651.0, 1160.1125139268465, 1169.222467059413, 1208.3052244959183, 1209.866914639389, 1210.1770795858724, 20857.478563036046, 22363.776362236822, 22443.32670019902, 22537.0, 22681.773182268626, 51234.74382628063, 63248.0, 63366.68316658387, 63460.0, 63502.68248658727, 90016.54991725, 90259.0, 90595.54702226447, 90621.0, 93110.53444733004, 12078.51685932588, 12183.451744671334, 12524.937375313066, 12871.712828717053, 12906.806397904227, 13633.863661363259, 13819.378127984064, 13937.512187073404, 13938.721225575635, 14126.434942602591, 10085.344452610558, 10756.408397538211, 10937.234393592691, 11785.823212651645, 11852.466639001093, 10059.346142500714, 10911.0, 11002.229843910849, 11156.832647510457, 11176.776464470828, 11534.192606517463, 11570.652880413601, 11711.824322635337, 12027.579034733742, 12137.393130343624, 12423.937880310541, 12516.311602861566, 12853.293068881301, 12903.354832258537, 13178.143420677625, 10877.836832447361, 11118.221724479208, 11634.70913227176, 11991.22057066288, 12035.518579257083], "value": 11855.157323591084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.772307123182, 1332.726791007844, 1422.1751384197166, 1426.2654732812603, 1441.3585954250357, 10755.83866242007, 11137.72155696108, 11230.045446137077, 11252.15608829338, 11257.43712814358, 11072.612458563952, 11168.0, 11215.439228038606, 11225.438728063606, 11225.719357016078, 2450.362905644532, 2477.1453848422357, 2482.0692240409844, 2482.503499300138, 2483.863387513686, 2363.5036642305136, 2380.27401642499, 2381.142788596104, 2385.129427758864, 2395.1138078910826, 2330.242671131889, 2356.96464553031, 2368.786809187173, 2452.877356132195, 2462.9753702463013, 2270.489139943516, 2400.4838959623676, 2407.410184504799, 2410.108259943832, 2433.3186707721866, 2056.9177232910665, 2136.957260854774, 2355.705536807899, 2395.6406539019113, 2409.6024156014237, 11075.280106793114, 11095.944520277348, 11161.330320180816, 11178.720531986684, 11206.887931120666, 5796.855078623026, 6300.117983482316, 6304.684765761694, 6325.430711236011, 6331.493480521547, 3828.5214348206473, 3903.8438462461468, 3907.6678482329035, 3928.4696565963513, 3997.2405243003736, 1212.2302338015336, 1534.3709079277442, 1575.58247064528, 1604.2620394618489, 1635.4848222809896, 12891.87108128916, 14201.218932958684, 15197.392104315813, 15206.847931520653, 15227.086374817436, 5221.216817477409, 5446.754896029688, 5479.726013699299, 5486.067368547357, 5550.528205102531, 11409.03023243017, 11470.369129697947, 11497.080233581293, 11507.19449638534, 11515.942420288013, 6241.812745617639, 6305.716242769086, 6320.652364119926, 6321.241451025906, 6332.556721029576, 5595.552355811526, 5760.963026655242, 5763.135529670583, 5841.9415805842245, 5979.551533634908, 4083.530394004668, 4208.8316467340965, 4259.61663450291, 4262.339337402707, 4305.74165550068, 1211.787937111002, 1216.4404373987888, 1225.1301575881046, 1227.1900545640012, 1228.6068458093325, 626.5676683088654, 746.73117677636, 769.2461387839949, 770.9961450192714, 781.3788038509399, 5004.4995500450395, 5701.287339082614, 5801.361850196475, 6007.429294217042, 6051.334353221142, 563.7575842387813, 567.9403662615448, 589.1016200294586, 596.0522768797632, 599.1701493431628, 3739.495168152319, 4044.6157615026527, 4120.567340429272, 4250.341197114452, 4325.4593175853015, 13053.0, 14210.431582736781, 14218.644533886736, 14243.0, 14272.928635356964, 13703.314834258248, 13783.035187536976, 14007.49474818739, 14140.43438262458, 14223.573292801233, 10188.032136946978, 10254.897451025543, 10267.870534241227, 10313.535890885078, 10367.844482332772, 6460.644664543495, 6474.708638111202, 6487.870242595216, 6535.607863528204, 6648.135742353463, 11217.66347009591, 12336.81494777561, 12353.444095015926, 12629.747405051663, 12653.051021173265, 12834.422450989914, 12837.807432888327, 12999.0, 13090.280034598189, 13113.147645403018, 8182.681257182879, 8272.710455134042, 8293.668253269801, 8392.03491598474, 8402.579871006548, 10075.848862266925, 10111.3427627204, 10154.339967902062, 10233.897661023593, 10237.897621023694, 7332.706691732485, 8408.864803251483, 8644.654213831376, 8670.696525621574, 8724.127587241224, 8416.957915210629, 8535.061143274359, 8546.316294696533, 8615.439996400213, 8660.48037117775, 6944.756933507303, 7728.26581474759, 7812.3750099993, 7939.603019848869, 7941.642626081724, 5276.76254568553, 5867.882642347215, 5969.701514924323, 6036.154938308552, 6075.969620151871, 5844.6493210405815, 5864.648121112747, 6051.577879198297, 6089.756409743561, 6236.126942228001], "value": 5107.682069629269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.81955202846547, 381.28509045539613, 383.08824996508343, 398.9920201595968, 403.6931931731885, 6163.722632481538, 6354.936450635492, 6418.19772528434, 6457.3865482779065, 6507.479401647869, 6094.664793436359, 6273.0, 6290.433860952513, 6295.811125666238, 6311.905321420182, 3760.0, 4177.908347822605, 4802.519748025195, 4808.495108013661, 4820.638452116105, 3971.4837071180705, 4590.954090459103, 4733.502982186872, 4734.360861283717, 4815.277708343741, 4331.43691320128, 4551.499335073139, 4708.646851486135, 4712.078511322985, 4726.952730472703, 4732.313814496896, 4745.406824146981, 4754.0967216229155, 4762.785674644615, 4763.880902977418, 4006.979965100156, 4162.458880345566, 4199.9790001050105, 4210.978945105286, 4220.345846393814, 4956.826511072131, 5804.216430781833, 5942.494887934531, 6084.482818960394, 6176.629402235835, 5615.691136987464, 5630.71846407678, 5643.548516118701, 5646.350669672999, 5649.491545760901, 6458.2895881453005, 6688.829454845382, 6748.797536073926, 6773.288804675487, 6796.184457865038, 4162.8353256306555, 4203.4115223868685, 4633.582977532038, 4792.0, 4800.519948005206, 6086.113304875503, 6206.410391012847, 6797.422219111381, 6970.651467426659, 7187.676554555058, 4084.244414783275, 4623.514530974267, 4859.319695242598, 4894.632902532324, 4964.205727083721, 4399.802008909543, 4971.776270067856, 4974.751262436864, 4994.150994330972, 5005.199168133154, 5375.650582712111, 5556.555475561945, 5607.52336051432, 5643.802466913638, 5649.37856835756, 6714.515629217123, 6739.0, 6754.696038678271, 6766.391024807693, 6767.492438067165, 1501.6621260216364, 1698.3716025070803, 1700.676871394456, 1712.6574685063038, 1719.5701074731317, 1145.410113791398, 1152.6005425752999, 1157.8784227655974, 1161.5085641299534, 1179.4161889864572, 5309.495597918191, 5377.542908852792, 5821.883562328814, 6212.285587157445, 6251.624902505864, 5796.826095217066, 6486.735086658056, 6934.791956241321, 6969.930300697029, 6984.0, 4914.5576898078625, 5638.830835074954, 6234.688265586702, 6265.248170219512, 6273.309935907047, 3052.6947305269296, 3177.5710279112486, 3550.875229797761, 3567.464880267981, 3638.7270954678506, 6366.522510811615, 6387.968060159762, 6500.674966251669, 6982.860342793116, 7180.389666878269, 5760.711964401763, 6045.0, 6395.456386207132, 7258.0, 7291.8906216406795, 5814.825555233349, 6181.196444462281, 6487.578307410004, 7072.434205263567, 7124.430045596444, 6617.43751781104, 6665.966670166618, 6896.689628970479, 7036.261192574911, 7049.647517623996, 5993.790217342372, 6855.657217139223, 6876.621785801829, 6918.169819621678, 6935.202451718117, 5766.481016708349, 6858.587668478456, 7129.429645628234, 7132.928670713434, 7134.0, 4405.361222622638, 4454.688171827941, 4459.420275364311, 4480.215962206666, 4481.574250446202, 6078.848028799315, 6517.283098859027, 6783.864322713617, 6892.655367231518, 6926.93073069283, 5597.664140151441, 6642.6014439133805, 6698.531102822755, 6723.327667233238, 6732.865342693217, 5823.5923485355615, 6673.232578253563, 6699.732010719516, 6710.295418980937, 6715.630640314635, 6346.365363463617, 6557.311482294481, 6558.573692709959, 6583.407493325623, 6593.450539123398, 5025.386798864643, 6414.166158399378, 6447.387498187664, 6656.101426307387, 6668.066050937572, 5815.621984570989, 5905.232319798399, 6284.694983936019, 6517.0, 6528.738850445929], "value": 4894.6100139510545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.284001917852, 692.9203141638714, 711.0933559711364, 716.8745469542832, 737.9446541509388, 12844.871551284485, 16371.75442368364, 16574.50276491704, 16753.99476031436, 16903.323867045336, 14898.776518352233, 15215.619609509768, 15230.695386092271, 15323.0, 15444.459443919437, 979.4221409368471, 1004.9598016079348, 1016.6492560066765, 1017.1506791828832, 1020.2857999400412, 995.7311525888006, 1022.6420752736557, 1029.0532709906904, 1041.536516250269, 1047.8533005379254, 1089.536946797608, 1089.84742136101, 1091.1761619976946, 1091.2034215023039, 1095.583678202282, 1066.5733706517378, 1078.7680648660576, 1083.3716444462232, 1083.5828206140613, 1084.5390708948705, 673.3804899492429, 785.3010820369875, 799.5242830515833, 802.9718959836378, 807.0678366486717, 16675.91662041682, 16983.23575439108, 17015.659686806193, 17110.058946757923, 17458.30166793327, 14966.551003469913, 15047.172405517693, 15100.848991510054, 15232.390704371812, 16027.118508482028, 11583.76832463346, 11657.242279251821, 11704.47329870158, 11828.704282392922, 12274.938625306906, 3017.09487153853, 3025.13783571681, 3089.675584063686, 3129.874805007797, 3192.3296107817387, 122394.38802806108, 125222.0, 127571.0, 128887.35556322252, 130623.0, 9985.251106167067, 10173.237007224488, 11179.0, 11466.770664586662, 11730.94134529339, 25235.369115772253, 25322.366940826625, 25481.745182548308, 25563.61654575183, 25760.48479030409, 7935.166807485246, 8005.239502247394, 8069.919300807034, 8099.433039687283, 8253.876191857127, 4283.0, 4322.762248076386, 4325.480942286883, 4360.171567402247, 4430.113977204572, 4228.619424251832, 4285.3786201000685, 4333.025069359432, 4340.544242854518, 4365.236083685342, 658.713459645056, 749.9212582678849, 752.7102065704743, 758.7382353088176, 774.8992630958052, 527.7229454536399, 545.2693390856272, 564.8503146666137, 590.3771521045253, 592.5407808948099, 9638.9036109638, 9776.413415195111, 10262.743431414274, 10297.9485102574, 10539.209559283085, 542.7245971965928, 560.71964017991, 576.0638961687258, 585.3385674188225, 612.7059011674421, 4684.156851766715, 4771.355866957986, 4785.425748910084, 4789.95210047902, 4809.687370320918, 109734.0, 110078.44960775145, 110612.0, 111231.44384278027, 111782.0, 84983.0, 85992.57003715067, 86068.0, 87425.1257487417, 87484.0, 84156.0, 84552.0, 85733.57133214294, 86647.56676216704, 87219.56390218009, 9590.66432674853, 9689.9031009689, 9714.3199976001, 9719.46542940145, 9777.85333219988, 40374.0, 41251.58748412477, 41517.37723934204, 41745.94683770897, 42058.0, 41848.79075604602, 53376.0, 53906.46093539015, 54288.0, 54767.72616136894, 11696.94151529271, 11738.647840564796, 11830.40847957616, 11967.281963082243, 12285.324307163191, 12474.128880667973, 12707.301098439675, 13041.478340866639, 13361.398737056661, 14407.543299795503, 14133.929330353694, 14247.928760356132, 14256.572302830931, 14622.122672639676, 14767.187804670846, 14089.418777943369, 14164.291785410895, 14281.0, 14292.499762508678, 15045.924770376078, 13774.793378099537, 13820.37808298649, 13913.590227252296, 13982.650433739238, 14938.551843444715, 8920.598573064357, 10300.948495257475, 10575.206859485415, 10580.259381843198, 11017.11863050938, 9347.098909754242, 10017.949910250401, 11223.887761122285, 11345.659630211107, 11635.41822908868], "value": 7697.141462208025, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1654.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 123.0, 121.0, 121.0, 125.0, 121.0, 122.0, 144.0, 124.0, 150.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 134.0, 195.0, 104.0, 141.0, 155.0, 102.0, 175.0, 156.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 227.0, 227.0, 221.0, 253.0, 303.0, 291.0, 215.0, 215.0, 229.0], "value": 240.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 78.0, 118.0, 87.0, 89.0, 61.0, 58.0, 73.0, 57.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 88.0, 73.0, 72.0, 75.0, 85.0, 74.0, 72.0, 88.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 91.0, 97.0, 96.0, 141.0, 139.0, 92.0, 92.0, 91.0, 90.0], "value": 104.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 99.0, 101.0, 99.0, 100.0, 101.0, 99.0, 101.0, 100.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 101.0, 124.0, 148.0, 100.0, 128.0, 101.0, 101.0, 99.0, 101.0], "value": 116.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 52.0, 51.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 58.0, 63.0, 71.0, 65.0, 58.0, 60.0, 59.0, 57.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 106.0, 124.0, 114.0, 95.0, 87.0, 87.0, 87.0, 86.0], "value": 96.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 145.0, 162.0, 175.0, 169.0, 169.0, 166.0, 212.0, 170.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 204.0, 215.0, 252.0, 220.0, 198.0, 201.0, 194.0, 191.0, 250.0], "value": 215.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 74.0, 76.0, 93.0, 88.0, 71.0, 72.0], "value": 76.3, "unit": "score"}]}]} 04:52:29 INFO - Return code: 0 04:52:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:29 ERROR - # TBPL SUCCESS # 04:52:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:29 INFO - 2017-04-03 04:52:29.997 screenresolution[1668:11075] starting screenresolution argv=screenresolution get 04:52:30 INFO - 2017-04-03 04:52:30.000 screenresolution[1668:11075] Display 0: 1600x1200x32@60 04:52:30 INFO - 2017-04-03 04:52:30.006 screenresolution[1669:11078] starting screenresolution argv=screenresolution list 04:52:30 INFO - Available Modes on Display 0 04:52:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:30 INFO - Intel Iris: 04:52:30 INFO - Chipset Model: Intel Iris 04:52:30 INFO - Type: GPU 04:52:30 INFO - Bus: Built-In 04:52:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:30 INFO - Vendor: Intel (0x8086) 04:52:30 INFO - Device ID: 0x0a2e 04:52:30 INFO - Revision ID: 0x0009 04:52:30 INFO - Displays: 04:52:30 INFO - Display: 04:52:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:30 INFO - Display Serial Number: 1600x1200 60 04:52:30 INFO - Main Display: Yes 04:52:30 INFO - Mirror: Off 04:52:30 INFO - Online: Yes 04:52:30 INFO - Rotation: Supported 04:52:30 INFO - Return code: 0 04:52:30 INFO - Running post-action listener: _resource_record_post_action 04:52:30 INFO - [mozharness: 2017-04-03 11:52:30.261115Z] Finished run-tests step (success) 04:52:30 INFO - Running post-run listener: _resource_record_post_run 04:52:30 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32215552; Write bytes: 514996224; Read time: 204; Write time: 1620 04:52:30 INFO - TinderboxPrint: CPU usage
54.3% 04:52:30 INFO - TinderboxPrint: I/O read bytes / time
32,215,552 / 204 04:52:30 INFO - TinderboxPrint: I/O write bytes / time
514,996,224 / 1,620 04:52:30 INFO - TinderboxPrint: CPU idle
2,194.6 (45.7%) 04:52:30 INFO - TinderboxPrint: CPU system
965.8 (20.1%) 04:52:30 INFO - TinderboxPrint: CPU user
1,641.4 (34.2%) 04:52:30 INFO - TinderboxPrint: Swap in / out
240,173,056 / 0 04:52:30 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205138432; Write bytes: 202694656; Read time: 15617; Write time: 439 04:52:30 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30405120; Write bytes: 301488128; Read time: 187; Write time: 1146 04:52:30 INFO - Running post-run listener: _upload_blobber_files 04:52:30 INFO - Blob upload gear active. 04:52:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:30 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 04:52:30 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'] 04:52:30 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 04:52:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:31 INFO - (blobuploader) - INFO - Done attempting. 04:52:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:33 INFO - (blobuploader) - INFO - Done attempting. 04:52:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:52:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:52:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:34 INFO - (blobuploader) - INFO - Done attempting. 04:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:37 INFO - (blobuploader) - INFO - Done attempting. 04:52:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:37 INFO - Return code: 0 04:52:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/612b38b7f0742c46223d7476df392e4ff4ac6cb7c8a5fb1969530566117253411d6fd4e6653c9ec9960f85dbe59e4adaf988d328c9aee9efc577236d3fff50d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad63b23cd0b1f328e9e2c50cfab35e05c2783d25313f89b0781e5c267633f65c8b367164c24ba5fa17631d1bf2d4791df114f7a4374986dd22bbb006f619668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba4364539e25e5c6e3c5c3d44ef54d6d7dfa1f0f0d4142bcdda103dc59be1ecd93f88a093f433308ca00420e4ed44769873170963e3aba38127fb3bb1534bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bfa8c94cff91e152b21cfe100bd5ab1e8877e8cf8ac50c21efc282d00db50f272923c78f851c6c9ba2288650f9eb731f9c68842ad4d9350e351889f5259fd0"} 04:52:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:37 INFO - Contents: 04:52:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/612b38b7f0742c46223d7476df392e4ff4ac6cb7c8a5fb1969530566117253411d6fd4e6653c9ec9960f85dbe59e4adaf988d328c9aee9efc577236d3fff50d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad63b23cd0b1f328e9e2c50cfab35e05c2783d25313f89b0781e5c267633f65c8b367164c24ba5fa17631d1bf2d4791df114f7a4374986dd22bbb006f619668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba4364539e25e5c6e3c5c3d44ef54d6d7dfa1f0f0d4142bcdda103dc59be1ecd93f88a093f433308ca00420e4ed44769873170963e3aba38127fb3bb1534bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bfa8c94cff91e152b21cfe100bd5ab1e8877e8cf8ac50c21efc282d00db50f272923c78f851c6c9ba2288650f9eb731f9c68842ad4d9350e351889f5259fd0"} 04:52:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:37 INFO - Copying logs to upload dir... 04:52:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1389.874135 ========= master_lag: 0.41 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 10 secs) (at 2017-04-03 04:52:37.300366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:52:37.304237) ========= 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.0mdc71FJah/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.7MwAPpw79y/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/612b38b7f0742c46223d7476df392e4ff4ac6cb7c8a5fb1969530566117253411d6fd4e6653c9ec9960f85dbe59e4adaf988d328c9aee9efc577236d3fff50d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad63b23cd0b1f328e9e2c50cfab35e05c2783d25313f89b0781e5c267633f65c8b367164c24ba5fa17631d1bf2d4791df114f7a4374986dd22bbb006f619668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba4364539e25e5c6e3c5c3d44ef54d6d7dfa1f0f0d4142bcdda103dc59be1ecd93f88a093f433308ca00420e4ed44769873170963e3aba38127fb3bb1534bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bfa8c94cff91e152b21cfe100bd5ab1e8877e8cf8ac50c21efc282d00db50f272923c78f851c6c9ba2288650f9eb731f9c68842ad4d9350e351889f5259fd0"} build_url:https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010918 build_url: 'https://queue.taskcluster.net/v1/task/T8_tdzTiTXycbVk53MVSqQ/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/612b38b7f0742c46223d7476df392e4ff4ac6cb7c8a5fb1969530566117253411d6fd4e6653c9ec9960f85dbe59e4adaf988d328c9aee9efc577236d3fff50d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad63b23cd0b1f328e9e2c50cfab35e05c2783d25313f89b0781e5c267633f65c8b367164c24ba5fa17631d1bf2d4791df114f7a4374986dd22bbb006f619668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba4364539e25e5c6e3c5c3d44ef54d6d7dfa1f0f0d4142bcdda103dc59be1ecd93f88a093f433308ca00420e4ed44769873170963e3aba38127fb3bb1534bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bfa8c94cff91e152b21cfe100bd5ab1e8877e8cf8ac50c21efc282d00db50f272923c78f851c6c9ba2288650f9eb731f9c68842ad4d9350e351889f5259fd0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 04:52:37.344040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:52:37.344473) ========= 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.0mdc71FJah/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.7MwAPpw79y/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005099 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:52:37.394694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:52:37.395022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 04:52:37.395414) ========= ========= Total master_lag: 2.98 =========