builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0383 starttime: 1486054303.31 results: success (0) buildid: 20170202072408 builduid: 1064872e177c4087995492c02d86410d revision: 96f96e97c8614c96471631f502694027a48f40ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.309418) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.309927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.310201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.335872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.336180) ========= 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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-02-02 08:51:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-02-02 08:51:43 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.490134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.490511) ========= 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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.024526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:43.540581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 08:51:43.541136) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96f96e97c8614c96471631f502694027a48f40ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 96f96e97c8614c96471631f502694027a48f40ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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-02-02 08:51:43,643 truncating revision to first 12 chars 2017-02-02 08:51:43,643 Setting DEBUG logging. 2017-02-02 08:51:43,643 attempt 1/10 2017-02-02 08:51:43,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/96f96e97c861?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 08:51:45,610 unpacking tar archive at: mozilla-aurora-96f96e97c861/testing/mozharness/ program finished with exit code 0 elapsedTime=2.243609 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 08:51:45.809192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:45.809516) ========= script_repo_revision: 96f96e97c8614c96471631f502694027a48f40ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:45.809898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:45.810158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 08:51:45.829828) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-02 08:51:45.830140) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:51:46 INFO - MultiFileLogger online at 20170202 08:51:46 in /builds/slave/test 08:51:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:51:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:46 INFO - {'append_to_log': False, 08:51:46 INFO - 'base_work_dir': '/builds/slave/test', 08:51:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:51:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:46 INFO - 'branch': 'Mozilla-Aurora', 08:51:46 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:46 INFO - 'config_files': ('talos/mac_config.py',), 08:51:46 INFO - 'default_actions': ('clobber', 08:51:46 INFO - 'read-buildbot-config', 08:51:46 INFO - 'download-and-extract', 08:51:46 INFO - 'populate-webroot', 08:51:46 INFO - 'create-virtualenv', 08:51:46 INFO - 'install', 08:51:46 INFO - 'run-tests'), 08:51:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:46 INFO - 'download_minidump_stackwalk': True, 08:51:46 INFO - 'download_symbols': 'ondemand', 08:51:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:46 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:46 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:46 INFO - 'installer_path': 'installer.exe', 08:51:46 INFO - 'log_level': 'info', 08:51:46 INFO - 'log_name': 'talos', 08:51:46 INFO - 'log_to_console': True, 08:51:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:51:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:51:46 INFO - 'opt_config_files': (), 08:51:46 INFO - 'pip_index': False, 08:51:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:46 INFO - 'cmd': ('bash', 08:51:46 INFO - '-c', 08:51:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:46 INFO - 'enabled': True, 08:51:46 INFO - 'halt_on_failure': False, 08:51:46 INFO - 'name': 'check_screen_resolution'},), 08:51:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:46 INFO - 'cmd': ('bash', 08:51:46 INFO - '-c', 08:51:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:46 INFO - 'enabled': True, 08:51:46 INFO - 'halt_on_failure': False, 08:51:46 INFO - 'name': 'check_screen_resolution'},), 08:51:46 INFO - 'run_cmd_checks_enabled': True, 08:51:46 INFO - 'sps_profile': False, 08:51:46 INFO - 'sps_profile_interval': 0, 08:51:46 INFO - 'suite': 'dromaeojs-e10s', 08:51:46 INFO - 'system_bits': '32', 08:51:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:46 INFO - 'title': 't-yosemite-r7-0383', 08:51:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:46 INFO - 'use_talos_json': True, 08:51:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:46 INFO - 'work_dir': 'build'} 08:51:46 INFO - [mozharness: 2017-02-02 16:51:46.046440Z] Running clobber step. 08:51:46 INFO - Running pre-action listener: _resource_record_pre_action 08:51:46 INFO - Running main action method: clobber 08:51:46 INFO - rmtree: /builds/slave/test/build 08:51:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:48 INFO - Running post-action listener: _resource_record_post_action 08:51:48 INFO - [mozharness: 2017-02-02 16:51:48.478637Z] Finished clobber step (success) 08:51:48 INFO - [mozharness: 2017-02-02 16:51:48.478776Z] Running read-buildbot-config step. 08:51:48 INFO - Running pre-action listener: _resource_record_pre_action 08:51:48 INFO - Running main action method: read_buildbot_config 08:51:48 INFO - Using buildbot properties: 08:51:48 INFO - { 08:51:48 INFO - "project": "", 08:51:48 INFO - "product": "firefox", 08:51:48 INFO - "script_repo_revision": "production", 08:51:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:51:48 INFO - "repository": "", 08:51:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:51:48 INFO - "buildid": "20170202072408", 08:51:48 INFO - "pgo_build": "False", 08:51:48 INFO - "basedir": "/builds/slave/test", 08:51:48 INFO - "buildnumber": 34, 08:51:48 INFO - "slavename": "t-yosemite-r7-0383", 08:51:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:51:48 INFO - "platform": "yosemite_r7", 08:51:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:51:48 INFO - "branch": "mozilla-aurora", 08:51:48 INFO - "repo_path": "releases/mozilla-aurora", 08:51:48 INFO - "revision": "96f96e97c8614c96471631f502694027a48f40ae", 08:51:48 INFO - "stage_platform": "macosx64", 08:51:48 INFO - "builduid": "1064872e177c4087995492c02d86410d", 08:51:48 INFO - "slavebuilddir": "test" 08:51:48 INFO - } 08:51:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:51:48 INFO - Running post-action listener: _resource_record_post_action 08:51:48 INFO - [mozharness: 2017-02-02 16:51:48.482193Z] Finished read-buildbot-config step (success) 08:51:48 INFO - [mozharness: 2017-02-02 16:51:48.482301Z] Running download-and-extract step. 08:51:48 INFO - Running pre-action listener: _resource_record_pre_action 08:51:48 INFO - Running main action method: download_and_extract 08:51:48 INFO - mkdir: /builds/slave/test/build/tests 08:51: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')]} 08:51:48 INFO - trying https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:51:48 INFO - Downloading https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:51:49 INFO - Downloaded 1199 bytes. 08:51:49 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:51:49 INFO - Using the following test package requirements: 08:51:49 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:51:49 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:51:49 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:51:49 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'jsshell-mac.zip'], 08:51:49 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:51:49 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:51:49 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:51:49 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:51:49 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:51:49 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:51:49 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:51:49 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:51:50 INFO - Expected file size: 16356058 08:51:50 INFO - Obtained file size: 16356058 08:51:57 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:51:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:51:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:51:57 INFO - Fetch https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:51:58 INFO - Expected file size: 16356058 08:51:58 INFO - Obtained file size: 16356058 08:52:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:52:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:52:04 INFO - Fetch https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:52:05 INFO - Expected file size: 14403485 08:52:05 INFO - Obtained file size: 14403485 08:52:05 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')]} 08:52:05 INFO - trying https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:52:05 INFO - Downloading https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:52:07 INFO - Downloaded 73823827 bytes. 08:52:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:52:07 INFO - mkdir: /builds/slave/test/properties 08:52:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:07 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:07 INFO - Contents: 08:52:07 INFO - build_url:https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:52:08 INFO - Running post-action listener: _resource_record_post_action 08:52:08 INFO - Running post-action listener: set_extra_try_arguments 08:52:08 INFO - [mozharness: 2017-02-02 16:52:08.303738Z] Finished download-and-extract step (success) 08:52:08 INFO - [mozharness: 2017-02-02 16:52:08.303858Z] Running populate-webroot step. 08:52:08 INFO - Running pre-action listener: _resource_record_pre_action 08:52:08 INFO - Running main action method: populate_webroot 08:52:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:08 INFO - '--tppagecycles', 08:52:08 INFO - '7'], 08:52:08 INFO - 'tests': ['tsvgm']}}, 08:52:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:52:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:52:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['damp', 'tps']}, 08:52:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'tests': ['damp', 'tps']}, 08:52:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['dromaeo_dom']}, 08:52:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['basic_compositor_video']}, 08:52:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:52:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['a11yr', 08:52:08 INFO - 'ts_paint', 08:52:08 INFO - 'tpaint', 08:52:08 INFO - 'sessionrestore', 08:52:08 INFO - 'sessionrestore_no_auto_restore', 08:52:08 INFO - 'tabpaint']}, 08:52:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:52:08 INFO - 'ts_paint', 08:52:08 INFO - 'tpaint', 08:52:08 INFO - 'sessionrestore', 08:52:08 INFO - 'sessionrestore_no_auto_restore', 08:52:08 INFO - 'tabpaint']}, 08:52:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:52:08 INFO - 'ts_paint', 08:52:08 INFO - 'tpaint', 08:52:08 INFO - 'sessionrestore', 08:52:08 INFO - 'sessionrestore_no_auto_restore', 08:52:08 INFO - 'tabpaint']}, 08:52:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:52:08 INFO - 'ts_paint', 08:52:08 INFO - 'tpaint', 08:52:08 INFO - 'sessionrestore', 08:52:08 INFO - 'sessionrestore_no_auto_restore', 08:52:08 INFO - 'tabpaint']}, 08:52:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['a11yr', 08:52:08 INFO - 'ts_paint', 08:52:08 INFO - 'tpaint', 08:52:08 INFO - 'sessionrestore', 08:52:08 INFO - 'sessionrestore_no_auto_restore', 08:52:08 INFO - 'tabpaint']}, 08:52:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['a11yr', 08:52:08 INFO - 'ts_paint', 08:52:08 INFO - 'tpaint', 08:52:08 INFO - 'sessionrestore', 08:52:08 INFO - 'sessionrestore_no_auto_restore', 08:52:08 INFO - 'tabpaint']}, 08:52:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['tsvgx', 08:52:08 INFO - 'tsvgr_opacity', 08:52:08 INFO - 'tart', 08:52:08 INFO - 'tscrollx', 08:52:08 INFO - 'cart', 08:52:08 INFO - 'tsvg_static']}, 08:52:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:52:08 INFO - 'tsvgr_opacity', 08:52:08 INFO - 'tart', 08:52:08 INFO - 'tscrollx', 08:52:08 INFO - 'cart', 08:52:08 INFO - 'tsvg_static']}, 08:52:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'talos_options': ['--disable-e10s'], 08:52:08 INFO - 'tests': ['tp5o']}, 08:52:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:52:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'talos_options': ['--disable-e10s', 08:52:08 INFO - '--xperf_path', 08:52:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:08 INFO - 'tests': ['tp5n']}, 08:52:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:52:08 INFO - 'talos_options': ['--xperf_path', 08:52:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:08 INFO - 'tests': ['tp5n']}}, 08:52:08 INFO - 'talos.zip': {'path': '', 08:52:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:08 INFO - Running post-action listener: _resource_record_post_action 08:52:08 INFO - [mozharness: 2017-02-02 16:52:08.322852Z] Finished populate-webroot step (success) 08:52:08 INFO - [mozharness: 2017-02-02 16:52:08.322966Z] Running create-virtualenv step. 08:52:08 INFO - Running pre-action listener: _resource_record_pre_action 08:52:08 INFO - Running main action method: create_virtualenv 08:52:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:08 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 08:52:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:08 INFO - Using real prefix '/tools/python27' 08:52:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:12 INFO - Installing pip.................done. 08:52:12 INFO - Return code: 0 08:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:52:12 INFO - Reading from file tmpfile_stdout 08:52:12 INFO - Output received: 08:52:12 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) 08:52:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52:12 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')]} 08:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:12 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')]} 08:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:12 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:12 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 08:52:12 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 08:52:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:12 INFO - 'HOME': '/Users/cltbld', 08:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:12 INFO - 'LOGNAME': 'cltbld', 08:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:12 INFO - 'MOZ_NO_REMOTE': '1', 08:52:12 INFO - 'NO_EM_RESTART': '1', 08:52:12 INFO - 'PAGER': '/bin/cat', 08:52:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:12 INFO - 'PWD': '/builds/slave/test', 08:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:12 INFO - 'SHELL': '/bin/bash', 08:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:12 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:12 INFO - 'USER': 'cltbld', 08:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:12 INFO - 'XPC_FLAGS': '0x0', 08:52:12 INFO - 'XPC_SERVICE_NAME': '0', 08:52:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:12 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 08:52:12 INFO - Cleaning up... 08:52:12 INFO - Return code: 0 08:52:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:52:12 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')]} 08:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:12 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')]} 08:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:12 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:12 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 08:52:12 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 08:52:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:12 INFO - 'HOME': '/Users/cltbld', 08:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:12 INFO - 'LOGNAME': 'cltbld', 08:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:12 INFO - 'MOZ_NO_REMOTE': '1', 08:52:12 INFO - 'NO_EM_RESTART': '1', 08:52:12 INFO - 'PAGER': '/bin/cat', 08:52:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:12 INFO - 'PWD': '/builds/slave/test', 08:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:12 INFO - 'SHELL': '/bin/bash', 08:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:12 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:12 INFO - 'USER': 'cltbld', 08:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:12 INFO - 'XPC_FLAGS': '0x0', 08:52:12 INFO - 'XPC_SERVICE_NAME': '0', 08:52:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:12 INFO - Downloading/unpacking psutil>=3.1.1 08:52: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 08:52: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 08:52: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 08:52: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 08:52: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 08:52: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 08:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:16 INFO - Installing collected packages: psutil 08:52:16 INFO - Running setup.py install for psutil 08:52:16 INFO - building 'psutil._psutil_osx' extension 08:52:16 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 08:52:16 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 08:52:16 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 08:52:17 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 08:52:17 INFO - building 'psutil._psutil_posix' extension 08:52:17 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 08:52:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:52:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:52:17 INFO - ^ 08:52:17 INFO - 1 warning generated. 08:52:17 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 08:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:17 INFO - Successfully installed psutil 08:52:17 INFO - Cleaning up... 08:52:17 INFO - Return code: 0 08:52:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:52:17 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')]} 08:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:17 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')]} 08:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:17 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:17 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 08:52:17 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 08:52:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:17 INFO - 'HOME': '/Users/cltbld', 08:52:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:17 INFO - 'LOGNAME': 'cltbld', 08:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:17 INFO - 'MOZ_NO_REMOTE': '1', 08:52:17 INFO - 'NO_EM_RESTART': '1', 08:52:17 INFO - 'PAGER': '/bin/cat', 08:52:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:17 INFO - 'PWD': '/builds/slave/test', 08:52:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:17 INFO - 'SHELL': '/bin/bash', 08:52:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:17 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:17 INFO - 'USER': 'cltbld', 08:52:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:17 INFO - 'XPC_FLAGS': '0x0', 08:52:17 INFO - 'XPC_SERVICE_NAME': '0', 08:52:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:52: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 08:52: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 08:52: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 08:52: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 08:52: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 08:52: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 08:52:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:20 INFO - Installing collected packages: mozsystemmonitor 08:52:20 INFO - Running setup.py install for mozsystemmonitor 08:52:20 INFO - Successfully installed mozsystemmonitor 08:52:20 INFO - Cleaning up... 08:52:20 INFO - Return code: 0 08:52:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:20 INFO - 'HOME': '/Users/cltbld', 08:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:20 INFO - 'LOGNAME': 'cltbld', 08:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:20 INFO - 'MOZ_NO_REMOTE': '1', 08:52:20 INFO - 'NO_EM_RESTART': '1', 08:52:20 INFO - 'PAGER': '/bin/cat', 08:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:20 INFO - 'PWD': '/builds/slave/test', 08:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:20 INFO - 'SHELL': '/bin/bash', 08:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:20 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:20 INFO - 'USER': 'cltbld', 08:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:20 INFO - 'XPC_FLAGS': '0x0', 08:52:20 INFO - 'XPC_SERVICE_NAME': '0', 08:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:20 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 08:52:20 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 08:52:20 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 08:52:20 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 08:52:20 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 08:52:20 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 08:52:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:23 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 08:52:23 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 08:52:23 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 08:52:23 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 08:52:23 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 08:52:23 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 08:52:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:24 INFO - warning: no files found matching '*.txt' 08:52:24 INFO - no previously-included directories found matching 'build' 08:52:24 INFO - no previously-included directories found matching 'dist' 08:52:24 INFO - no previously-included directories found matching '.git*' 08:52:24 INFO - Installing collected packages: jsonschema, functools32 08:52:24 INFO - Running setup.py install for functools32 08:52:24 INFO - warning: no files found matching '*.txt' 08:52:24 INFO - no previously-included directories found matching 'build' 08:52:24 INFO - no previously-included directories found matching 'dist' 08:52:24 INFO - no previously-included directories found matching '.git*' 08:52:24 INFO - Successfully installed jsonschema functools32 08:52:24 INFO - Cleaning up... 08:52:24 INFO - Return code: 0 08:52:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:24 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')]} 08:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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')]} 08:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:24 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 08:52:24 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 08:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:24 INFO - 'HOME': '/Users/cltbld', 08:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:24 INFO - 'LOGNAME': 'cltbld', 08:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:24 INFO - 'MOZ_NO_REMOTE': '1', 08:52:24 INFO - 'NO_EM_RESTART': '1', 08:52:24 INFO - 'PAGER': '/bin/cat', 08:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:24 INFO - 'PWD': '/builds/slave/test', 08:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:24 INFO - 'SHELL': '/bin/bash', 08:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:24 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:24 INFO - 'USER': 'cltbld', 08:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:24 INFO - 'XPC_FLAGS': '0x0', 08:52:24 INFO - 'XPC_SERVICE_NAME': '0', 08:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:24 INFO - Cleaning up... 08:52:24 INFO - Return code: 0 08:52:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:24 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')]} 08:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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')]} 08:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:24 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:24 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 08:52:24 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 08:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:24 INFO - 'HOME': '/Users/cltbld', 08:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:24 INFO - 'LOGNAME': 'cltbld', 08:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:24 INFO - 'MOZ_NO_REMOTE': '1', 08:52:24 INFO - 'NO_EM_RESTART': '1', 08:52:24 INFO - 'PAGER': '/bin/cat', 08:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:24 INFO - 'PWD': '/builds/slave/test', 08:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:24 INFO - 'SHELL': '/bin/bash', 08:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:24 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:24 INFO - 'USER': 'cltbld', 08:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:24 INFO - 'XPC_FLAGS': '0x0', 08:52:24 INFO - 'XPC_SERVICE_NAME': '0', 08:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:24 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 08:52:24 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 08:52:24 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 08:52:24 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 08:52:24 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 08:52:24 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 08:52:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:28 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 08:52:28 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 08:52:28 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 08:52:28 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 08:52:28 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 08:52:28 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 08:52:28 INFO - Downloading docopt-0.6.1.tar.gz 08:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:28 INFO - Running setup.py install for blobuploader 08:52:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:28 INFO - Running setup.py install for requests 08:52:29 INFO - Running setup.py install for docopt 08:52:29 INFO - Successfully installed blobuploader requests docopt 08:52:29 INFO - Cleaning up... 08:52:29 INFO - Return code: 0 08:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:29 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:29 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 08:52:29 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 08:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:29 INFO - 'HOME': '/Users/cltbld', 08:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:29 INFO - 'LOGNAME': 'cltbld', 08:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:29 INFO - 'MOZ_NO_REMOTE': '1', 08:52:29 INFO - 'NO_EM_RESTART': '1', 08:52:29 INFO - 'PAGER': '/bin/cat', 08:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:29 INFO - 'PWD': '/builds/slave/test', 08:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:29 INFO - 'SHELL': '/bin/bash', 08:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:29 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:29 INFO - 'USER': 'cltbld', 08:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:29 INFO - 'XPC_FLAGS': '0x0', 08:52:29 INFO - 'XPC_SERVICE_NAME': '0', 08:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-M_qNjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-zgAeFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-pIsuQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-AenDzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-9j6vsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-UBV2Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-yGRhyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-y0BSUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-zPeYyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:30 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Impd8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-QL8Uzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-AlNfg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-VY1paZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-Dt0eas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-72R67H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-pdq0aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:31 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-PJvdhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:31 INFO - Running setup.py install for manifestparser 08:52:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:31 INFO - Running setup.py install for mozcrash 08:52:32 INFO - Running setup.py install for mozdebug 08:52:32 INFO - Running setup.py install for mozdevice 08:52:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Running setup.py install for mozfile 08:52:32 INFO - Running setup.py install for mozhttpd 08:52:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Running setup.py install for mozinfo 08:52:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Running setup.py install for mozInstall 08:52:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:32 INFO - Running setup.py install for mozleak 08:52:33 INFO - Running setup.py install for mozlog 08:52:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Running setup.py install for moznetwork 08:52:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Running setup.py install for mozprocess 08:52:33 INFO - Running setup.py install for mozprofile 08:52:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Running setup.py install for mozrunner 08:52:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:33 INFO - Running setup.py install for mozscreenshot 08:52:34 INFO - Running setup.py install for moztest 08:52:34 INFO - Running setup.py install for mozversion 08:52:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:34 INFO - Cleaning up... 08:52:34 INFO - Return code: 0 08:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:35 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:35 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 08:52:35 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 08:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:35 INFO - 'HOME': '/Users/cltbld', 08:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:35 INFO - 'LOGNAME': 'cltbld', 08:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:35 INFO - 'MOZ_NO_REMOTE': '1', 08:52:35 INFO - 'NO_EM_RESTART': '1', 08:52:35 INFO - 'PAGER': '/bin/cat', 08:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:35 INFO - 'PWD': '/builds/slave/test', 08:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:35 INFO - 'SHELL': '/bin/bash', 08:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:35 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:35 INFO - 'USER': 'cltbld', 08:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:35 INFO - 'XPC_FLAGS': '0x0', 08:52:35 INFO - 'XPC_SERVICE_NAME': '0', 08:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:35 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-jpTMQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:35 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)) 08:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:35 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-ChiDdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:35 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)) 08:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:35 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-MKOvU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:35 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)) 08:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:35 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-ApwTe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:35 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)) 08:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:35 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-iGt3f6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-ZL7jwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-37y242-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-4pTqAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-9uIpeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-YxOpgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-zaCtFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-721kfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-6q66ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-uPX5Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:36 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)) 08:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:36 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-kZInVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:37 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)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:37 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-uUnnD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:37 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)) 08:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:37 INFO - Running setup.py (path:/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/pip-TeIykB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:37 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)) 08:52:37 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)) 08:52:37 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)) 08:52:37 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)) 08:52:37 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)) 08:52:37 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)) 08:52:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:37 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 08:52:37 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 08:52:37 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 08:52:37 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 08:52:37 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 08:52:37 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 08:52:40 INFO - Downloading blessings-1.6.tar.gz 08:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:40 INFO - Installing collected packages: blessings 08:52:40 INFO - Running setup.py install for blessings 08:52:40 INFO - Successfully installed blessings 08:52:40 INFO - Cleaning up... 08:52:40 INFO - Return code: 0 08:52:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:40 INFO - Reading from file tmpfile_stdout 08:52:40 INFO - Current package versions: 08:52:40 INFO - blessings == 1.6 08:52:40 INFO - blobuploader == 1.2.4 08:52:40 INFO - docopt == 0.6.1 08:52:40 INFO - functools32 == 3.2.3-2 08:52:40 INFO - jsonschema == 2.5.1 08:52:40 INFO - manifestparser == 1.1 08:52:40 INFO - mozInstall == 1.12 08:52:40 INFO - mozcrash == 1.0 08:52:40 INFO - mozdebug == 0.1 08:52:40 INFO - mozdevice == 0.49 08:52:40 INFO - mozfile == 1.2 08:52:40 INFO - mozhttpd == 0.7 08:52:40 INFO - mozinfo == 0.9 08:52:40 INFO - mozleak == 0.1 08:52:40 INFO - mozlog == 3.4 08:52:40 INFO - moznetwork == 0.27 08:52:40 INFO - mozprocess == 0.24 08:52:40 INFO - mozprofile == 0.28 08:52:40 INFO - mozrunner == 6.13 08:52:40 INFO - mozscreenshot == 0.1 08:52:40 INFO - mozsystemmonitor == 0.3 08:52:40 INFO - moztest == 0.8 08:52:40 INFO - mozversion == 1.4 08:52:40 INFO - psutil == 3.1.1 08:52:40 INFO - requests == 1.2.3 08:52:40 INFO - wsgiref == 0.1.2 08:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:40 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:40 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 08:52:40 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 08:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:40 INFO - 'HOME': '/Users/cltbld', 08:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:40 INFO - 'LOGNAME': 'cltbld', 08:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:40 INFO - 'MOZ_NO_REMOTE': '1', 08:52:40 INFO - 'NO_EM_RESTART': '1', 08:52:40 INFO - 'PAGER': '/bin/cat', 08:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:40 INFO - 'PWD': '/builds/slave/test', 08:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:40 INFO - 'SHELL': '/bin/bash', 08:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:40 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:40 INFO - 'USER': 'cltbld', 08:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:40 INFO - 'XPC_FLAGS': '0x0', 08:52:40 INFO - 'XPC_SERVICE_NAME': '0', 08:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 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)) 08:52:41 INFO - Cleaning up... 08:52:41 INFO - Return code: 0 08:52:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:41 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 0x107cb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc712da95f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, '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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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 08:52:41 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 08:52:41 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 08:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:41 INFO - 'HOME': '/Users/cltbld', 08:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:41 INFO - 'LOGNAME': 'cltbld', 08:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:41 INFO - 'MOZ_NO_REMOTE': '1', 08:52:41 INFO - 'NO_EM_RESTART': '1', 08:52:41 INFO - 'PAGER': '/bin/cat', 08:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:41 INFO - 'PWD': '/builds/slave/test', 08:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:41 INFO - 'SHELL': '/bin/bash', 08:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:52:41 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:41 INFO - 'USER': 'cltbld', 08:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:41 INFO - 'XPC_FLAGS': '0x0', 08:52:41 INFO - 'XPC_SERVICE_NAME': '0', 08:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:41 INFO - Cleaning up... 08:52:41 INFO - Return code: 0 08:52:41 INFO - Running post-action listener: _resource_record_post_action 08:52:41 INFO - Running post-action listener: _start_resource_monitoring 08:52:41 INFO - Starting resource monitoring. 08:52:41 INFO - [mozharness: 2017-02-02 16:52:41.431281Z] Finished create-virtualenv step (success) 08:52:41 INFO - [mozharness: 2017-02-02 16:52:41.432219Z] Running install step. 08:52:41 INFO - Running pre-action listener: _resource_record_pre_action 08:52:41 INFO - Running main action method: install 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:41 INFO - Reading from file tmpfile_stdout 08:52:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:41 INFO - Reading from file tmpfile_stdout 08:52:41 INFO - Output received: 08:52:41 INFO - Usage: mozinstall [options] installer 08:52:41 INFO - Options: 08:52:41 INFO - -h, --help show this help message and exit 08:52:41 INFO - -d DEST, --destination=DEST 08:52:41 INFO - Directory to install application into. [default: 08:52:41 INFO - "/builds/slave/test"] 08:52:41 INFO - --app=APP Application being installed. [default: firefox] 08:52:41 INFO - mkdir: /builds/slave/test/build/application 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:53:01 INFO - Reading from file tmpfile_stdout 08:53:01 INFO - Output received: 08:53:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:53:01 INFO - Running post-action listener: _resource_record_post_action 08:53:01 INFO - [mozharness: 2017-02-02 16:53:01.668404Z] Finished install step (success) 08:53:01 INFO - [mozharness: 2017-02-02 16:53:01.668579Z] Running run-tests step. 08:53:01 INFO - Running pre-action listener: _resource_record_pre_action 08:53:01 INFO - Running main action method: run_tests 08:53:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:01 INFO - 2017-02-02 08:53:01.683 screenresolution[1623:7321] starting screenresolution argv=screenresolution get 08:53:01 INFO - 2017-02-02 08:53:01.685 screenresolution[1623:7321] Display 0: 1600x1200x32@60 08:53:01 INFO - 2017-02-02 08:53:01.691 screenresolution[1624:7324] starting screenresolution argv=screenresolution list 08:53:01 INFO - Available Modes on Display 0 08:53:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:01 INFO - Intel Iris: 08:53:01 INFO - Chipset Model: Intel Iris 08:53:01 INFO - Type: GPU 08:53:01 INFO - Bus: Built-In 08:53:01 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:01 INFO - Vendor: Intel (0x8086) 08:53:01 INFO - Device ID: 0x0a2e 08:53:01 INFO - Revision ID: 0x0009 08:53:01 INFO - Displays: 08:53:01 INFO - Display: 08:53:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:01 INFO - Display Serial Number: 1600x1200 60 08:53:01 INFO - Main Display: Yes 08:53:01 INFO - Mirror: Off 08:53:01 INFO - Online: Yes 08:53:01 INFO - Rotation: Supported 08:53:01 INFO - Return code: 0 08:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:01 INFO - Python 2.7.3 08:53:01 INFO - Return code: 0 08:53:01 INFO - grabbing minidump binary from tooltool 08:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:01 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 0x107a8ed30>, '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 0x1079b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a83be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:01 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 08:53:01 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 08:53:01 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 08:53:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:02 INFO - Return code: 0 08:53:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:53:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:53:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 08:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0383 --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 08:53:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NWK5Xsv2Rl/Render', 08:53:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:02 INFO - 'HOME': '/Users/cltbld', 08:53:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:02 INFO - 'LOGNAME': 'cltbld', 08:53:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:02 INFO - 'MOZ_NO_REMOTE': '1', 08:53:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:02 INFO - 'NO_EM_RESTART': '1', 08:53:02 INFO - 'PAGER': '/bin/cat', 08:53:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:02 INFO - 'PWD': '/builds/slave/test', 08:53:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:02 INFO - 'SHELL': '/bin/bash', 08:53:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CuHRSM6z2y/Listeners', 08:53:02 INFO - 'TMPDIR': '/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/', 08:53:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:02 INFO - 'USER': 'cltbld', 08:53:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:02 INFO - 'XPC_FLAGS': '0x0', 08:53:02 INFO - 'XPC_SERVICE_NAME': '0', 08:53:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0383', '--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 08:53:02 INFO - mozversion application_buildid: 20170202072408 08:53:02 INFO - mozversion application_changeset: 96f96e97c8614c96471631f502694027a48f40ae 08:53:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:53:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:02 INFO - mozversion application_name: Firefox 08:53:02 INFO - mozversion application_remotingname: firefox-dev 08:53:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:53:02 INFO - mozversion application_vendor: Mozilla 08:53:02 INFO - mozversion application_version: 53.0a2 08:53:02 INFO - mozversion platform_buildid: 20170202072408 08:53:02 INFO - mozversion platform_changeset: 96f96e97c8614c96471631f502694027a48f40ae 08:53:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:53:02 INFO - mozversion platform_version: 53.0a2 08:53:02 INFO - using testdate: 1486054382 08:53:02 INFO - actual date: 1486054382 08:53:02 INFO - starting webserver on 'localhost:49241' 08:53:02 INFO - SUITE-START | Running 2 tests 08:53:02 INFO - TEST-START | dromaeo_css 08:53:02 INFO - operating with platform_type : mac_ 08:53:02 INFO - Initialising browser for dromaeo_css test... 08:53:02 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpQeCfSL/profile http://localhost:49241/getInfo.html) 08:53:05 INFO - PROCESS | 1634 | 2017-02-02 08:53:05.472 plugin-container[1636:7501] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 08:53:05 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:53:05 INFO - PROCESS | 1634 | 2017-02-02 08:53:05.475 plugin-container[1636:7501] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9213, name = 'com.apple.CFPasteboardClient' 08:53:05 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:53:05 INFO - PROCESS | 1634 | 2017-02-02 08:53:05.475 plugin-container[1636:7501] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:53:05 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 08:53:05 INFO - PROCESS | 1634 | colorDepth:24 08:53:05 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 08:53:05 INFO - PROCESS | 1634 | __metrics 08:53:05 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:53:06 INFO - TEST-INFO | 1634: exit 0 08:53:06 INFO - Browser initialized. 08:53:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:06 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpQeCfSL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:09 INFO - PROCESS | 1637 | 2017-02-02 08:53:09.033 plugin-container[1638:7639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 08:53:09 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:53:09 INFO - PROCESS | 1637 | 2017-02-02 08:53:09.033 plugin-container[1638:7639] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:53:09 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:53:09 INFO - PROCESS | 1637 | 2017-02-02 08:53:09.033 plugin-container[1638:7639] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:53:18 INFO - PROCESS | 1637 | RSS: Main: 218509312 08:53:18 INFO - PROCESS | 1637 | 08:56:20 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:56:22 INFO - PROCESS | 1637 | RSS: Main: 236306432 08:56:22 INFO - PROCESS | 1637 | 08:58:06 INFO - PROCESS | 1637 | ************************* 08:58:06 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 08:58:06 INFO - PROCESS | 1637 | 08:58:06 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:58:06 INFO - PROCESS | 1637 | Full stack: 08:58:06 INFO - PROCESS | 1637 | ************************* 08:59:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:59:25 INFO - PROCESS | 1637 | RSS: Main: 244813824 08:59:25 INFO - PROCESS | 1637 | 09:02:27 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:02:28 INFO - PROCESS | 1637 | RSS: Main: 252624896 09:02:28 INFO - PROCESS | 1637 | 09:05:30 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:05:31 INFO - PROCESS | 1637 | RSS: Main: 251494400 09:05:31 INFO - PROCESS | 1637 | 09:08:34 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:08:34 INFO - PROCESS | 1637 | RSS: Main: 257581056 09:08:34 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:11:37 INFO - PROCESS | 1637 | RSS: Main: 261779456 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | __start_tp_report 09:11:37 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 09:11:37 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 09:11:37 INFO - PROCESS | 1637 | |i|pagename|runs| 09:11:37 INFO - PROCESS | 1637 | |0;dojo.html;3336.0659015475676;3352.2122301259205;3362.394768941591;3382.7124694400973;3384.543086683297;4481.955180448203;4978.651494395389;5451.618386712932;5456.499462647774;5720.685362305072;5708.08670612702;5712.1431785232235;5758.3665796762325;5782.161586569945;5788.507976821965;5245.213218017289;5247.23915032321;5265.236540701596;5325.254464374991;5326.920096198541;5281.9207711884355;5307.867303317409;5316.043112239795;5320.281761962144;5349.652272602288;4388.670849686287;5220.347456567929;5302.469753024686;5328.440513746059;5332.33345831771;5187.766550505217;5203.843884683465;5262.394824595182;5262.710550919698;5300.734963251822;5108.157154069574;5265;5289.418164001957;5304.867378315535;5322.65402748824;5786;5822.097574875858;5855.76576936922;5900.852478688024;5934.317553481319;6120.755169793203;6178.598391104564;6178.752849885999;6178.752849885999;6292.056191571301;6288.151099601541;6305.905411418832;6310;6311.8737625247695;6331.68341582919;5909.9704501477645;5929.377415371367;5931.58478906481;5931.64410135389;5987.5808693391045;6203;6240.563160578807;6251.9687401562705;6271.184745983084;6295.685215739195;6128.961487065963;6143.327652471189;6226.968865155736;6227.719752611143;6230.6573138476915;6271.247450305992;6272;6277.340879207617;6294.402031806971;6311.96844015777;5308.893822123536;6117.296510901214;6129.725578588854;6160.260768707783;6265.373462653698;6218.22272215973;6248.094026366151;6251.624902505864;6304.8423789404715;6305.527085468608;5006.249062640633;5007.198848184273;5018.949810501921;5036.11867923112;5043.722595257296;4385.846495372647;4504.099180163915;4515.345274935182;4522.140793249272;4527.683062185615;5759.798407055733;5762.135679648086;5781.508571771446;5790.334111577138;5902.1146827976145;6233.376662333731;6297.685115744194;6323;6323.841903952438;6335.461485773669;5660.377358490563;5728.742206600713;5782.479576838105;5793.04414771558;5816.5928385013485;4624.907501849944;5457.126859702428;5515.779368825282;5515.862103447446;5544.002079625626;6350.587211831216;6356.2054743157105;6372.0760489729655;6375.585586936834;6391.648459334781;6206.06908963659;6262.405071518198;6313.936860631335;6314.8317561251315;6330;6260.186175797299;6271.560990730605;6298.71655775482;6391.520635952415;6411.134496842867;6196.721147548281;6238.781642642486;6267.811965641038;6277.748890044347;6279.058141278845;4802.543758342952;4846.830360937351;4940.92588611164;6150.384961503813;6176.197094377702;6103.877922441615;6112.321110680095;6112.388761123852;6196.783112591038;6224.221972253468;6194.225721784777;6204.658743768956;6208.875822483616;6210.720517576629;6240.563160578898;5928.36148059586;6022.66875321844;6046.455818976313;6054.969725151346;6108.114323423168;5965.075413310944;6045.244344456943;6114.48026917717;6134.11055396956;6153.107799368977;5001.57486613642;5973;6032.517398608013;6044.123602077762;6049.969750151221 09:11:37 INFO - PROCESS | 1637 | |1;ext.html;443.9367714324194;446.0254344257795;477.00544364998984;490.51194061908404;491.1208936004552;27973.86013069937;41471.79264103675;41526.584734152646;41646.791766041206;41695;41817;42470.362944555854;42574.36138457926;42606;42606.36090458646;8415;9232.215261702746;9459.006804285555;9463.81072378552;9474.194693451065;8448.957755211215;9144;11180.329180249171;11426.71433214172;11555.19113662044;11346.546138154465;11385.373804440753;11392.601258955938;11398.658040258806;11433.485493152828;11370.204085713962;11445.542178312857;11456.828147577793;11470.082393408507;11507.712307192303;11297.378644174567;11340.943295283554;11389.487473063731;11394.430278486125;11430.71423214418;40701.592984070376;40856;41160.97097572555;41240.793796031125;41319.7934010331;4000.2599519089063;4007.1184339445276;4101.282275601788;4105.014796448861;4329.783510824446;28736.281592960135;29365;29385;31095;31708.04875853705;3220.9355812883846;3236.449803533405;3249.951250731241;3334.749893757978;3377.0713053910126;481265;489084.5545772284;490338;490467;492450.9999999964;52984;61580.384196157465;61836.38163618396;61939;63706.40733981688;64356;65263;65309.67345163339;65389.01916471257;65585.67207164029;16012.279447424893;16561;16593.585160371087;16599.253033613517;16623.168841558116;12231.021518278516;12430.316332601793;12495.125341226209;12923.935380323039;13055;18196.272149113887;18380.816191838177;18421.90789046046;18449.631007379776;18545.35091271799;7812.648430820626;7851.646675899598;7886.067913361263;7938.325242354349;8000.479968802126;874.8075423406967;887.3123329419751;894.2845723421237;900.2213085680839;930.7481437466597;25820.870895645403;29348.385838778646;30070.54894176589;30631.40314579845;31152;949.2358651285781;1016.2022812092472;1088.684281558355;1090.9345439273668;1116.430620383594;14508.372906773307;15309.770353444706;15347.309371078329;15427.768583471257;15823.287952041956;557419;681145;682070;682144;685412;61788;62150;62286;62310.688446558386;62540.68729656414;1423.4306277489088;1438.8201474815648;1460.5399299220712;1463.7072585482947;1465.8607432293916;29250.707492924797;30089.94685186008;30232.395352092393;30292.697073028987;30443.11033462194;51339.48660513347;51423;51707.741461292455;51914.48085519097;51941.7402912983;580552;584122;585189;587374;587422.1257787539;23167;23864.403389914696;25933.87033064898;26758.732412675625;26802.061927832434;42666.57333426626;46975;48108;48239.75880120577;48796.024079518924;35418;35983;36256.81871590625;36261;36648.45027324645;36030.63969360273;36294.8185259072;36575;36664.05113775516;36953.44569831508;35273.294534109686;35416.822915885255;35696;37097.25805483821;37348.81325593355;31526.369472610877;32512.187195320304;32683.836580816944;32729.85445509396;32922.50616240806;24086.87956560206;24572.50854982926;24721.50556988814;24998.37504062413;25011 09:11:37 INFO - PROCESS | 1637 | |2;jquery.html;394.8321963165654;395.1898607853899;397.0332240993184;400.8857475619449;422.36223302812743;19970.800291997075;20970;21391.03740331685;21410;21521.24675636353;20705.96470176489;20914.68627970578;20961.790382096173;21161.68257476139;21374.358769236947;5658.405867383927;5944.910826337608;5967.850803729898;5971.044632858743;5991.221141251631;5501.752421141038;5665.603407761459;5770.961226979142;5926.170336152921;5938.317093534234;5007.223880298559;5797.797077102302;5798.739056742456;5801.709914504279;5809.3609702932645;4072.9389059164137;5523.696196709159;5544.556435485151;5785.508231800281;5810.1284807279035;5068.467810879878;5081.085404627165;5087.313212716273;5087.364079490064;5107.514786095315;25546.744532554807;25705.357366065997;25850.965961361522;25920.74079259202;26146.215613531433;3019.5772591837163;3047.6342838859478;3052.3895220955897;3080.7997480163717;3096.071178646397;14907.627309317246;15407.152606606744;15446.382144714198;15456.072635641898;15750.369985200578;1819.7452356670076;1821.5172979160534;1822.3803906671662;1846.9722954155698;1847.7228415737613;122498;126741;126794.36602816927;127546;128159.07761383493;10799.082078023299;10941.617043403443;11441.828372574419;11535.711607209887;11664.183507154417;11889.881101188877;14067;14162.433502659984;14318.14091154534;14357.6410589734;7477.551346919202;8105.473144245605;8465.449745766506;8697.304025714924;8707.259882909897;7168.641567921583;8564.186402291773;8595.5702214889;8596.140385961478;8621.69824056155;6037.486813620892;6948.861022779516;6959.408450281681;7070.328318809705;7113.039739635186;1662.2852173565484;1961.205711686769;1985.7120717495882;1987.3839109875985;1989.7365173115177;1046.4610725476234;1070.3356280982991;1080.778440419712;1105.6019832860163;1121.7644294698205;20705.378838634864;21759.564808704054;21778;21791.67312490314;22032.33902982913;953.8506100149303;1073.9892601073889;1105.4914739219887;1111.2998810749177;1124.5614210457927;11272;11522.53909843597;11653.941730291293;11675.12436567261;11723.062155027577;587249;602014;607555;654714;668960;114022.85977140289;137630.31184844012;143474;160020;166804;959.5346257065318;991.9404835709736;1041.6250149946165;1044.5038606661774;1045.8849526552074;18670.719939201193;19092.045397730337;19299.421017369503;19335.8066419334;19373.612527749647;39213.41179882361;54313.09904153336;54344.18483722826;57652.71173644105;58677.70661146838;56145.43854561402;76887.61556192183;82204;83671;84461;8087.757367278991;8384.53885036329;8413.95793021031;8445.535495547558;8473.110323415953;8902.59938302791;9602.711918642452;11127.777444451227;11897.512810898637;13386.866131338562;11376.203665743318;11390.37352945596;11457.885421145682;11786.469608867794;11909.94045029804;11324.660260192208;11487.425628718363;11532.88467115318;11837.704057398634;11925.821112683143;9824.45965471906;11353.318800871974;11447.370394628042;12092.39538023113;12130.211536250115;8137.552434616153;8322.37582181351;8412.411131220755;8463.66145354179;8479.745607631781;9429.104942113781;11250.7749845001;11545.826812597987;11573.18987670855;11655.533778649098 09:11:37 INFO - PROCESS | 1637 | |3;mootools.html;1295.339376917772;1421.6232698334943;1427.614544073101;1432.8065711128995;1445.64581677489;7512.737054203104;7757.418193635472;8097.068837083737;8521.147885211476;8530.976282846068;7988.520688758664;8278.461899976512;8295.543745094017;8367.2469477747;8378.664853405857;2308.5844547981355;2339.6841426407473;2340.695709557755;2349.3774149850306;2360.4570948681812;1984.2360691133945;2065.215218217083;2327.8021368183727;2360.33910505058;2366.1127077345996;2203.2839327218717;2279.6922415473946;2280.4754906371545;2285.223024171781;2287.794098531132;2313.3175713164655;2314.9537009259807;2332.685087513198;2341.613633750421;2342.695449591542;1980.039680754847;2343.4610039690797;2356.658284548748;2371.750966148547;2380.5595964746576;8231.506109633441;8441.57792110392;8456.704015359433;8462.449940753831;8471.068182499981;5086.491350864921;5248.81629142982;5258.132408152688;5262.473752624745;5290.60320475962;3456.792592444436;3473.99254216277;3490.225270909633;3525.806080665562;3563.55455568054;1206.1858245684127;1208.848893888264;1257.8930790882694;1268.346801397272;1271.631226944185;10819;10899.12806975448;10899.673009809718;10900.781984360348;10916.563337466492;4344.56554344563;4459.531749166355;4682.484926658065;4760.809567617326;4767.76161191939;8653.783655408664;9543.61825526985;9571.760705982268;9580.56887440067;9588.66439674608;5187.118189907725;5268.394134674485;5272.630915835932;5274.340707411574;5306.9386122775595;4218.6835987300465;4528.275475923836;4796.304535842283;4812.133815913169;4856.538628830326;3884.31032500863;3920.941185882214;3931.4692516510477;3970.5830887756947;3993.0815912340327;1169.497116240025;1199.9820002699967;1286.2604002698486;1286.6075846866795;1300.9917314081474;714.8034290570134;764.2853931573997;777.2654841175035;834.3742193354984;835.1231207232503;4972.950270497321;5038.546530812171;5221.530062294411;5750.619851235673;5867.823965281048;942.3026960049514;993.7726907269516;996.4121168510613;1041.9687409377732;1042.4891803016467;3799.4680744695765;3890.708196885245;3908.218356328689;3961.207758448322;4043.555208927016;9581.856272155923;9794;10117.949410253048;10125.898741012643;10182.439965801952;9076.319276054322;9144.405613635092;9443.866735991587;10080.596776128872;10103.898961010296;7491.475596708287;7838.921610783819;7853.332466740277;7860.489068210548;8023.759287221276;4209;5260.0005998861625;5819.592628516132;5885.47030767233;5951.732172052181;7754.961225193838;8992.775180620536;9111.088891110836;9197;9312.627494900127;8963.59663815143;9266.166045055978;9298.72103836886;9321.50754018512;9359.391639543408;6804.21751498584;6912.170539535288;6963.582185068912;6966.268541803038;6985.371316581329;7872.370210383041;7891.250331218525;7929.762107136795;7947.960260198662;7978.361731061617;7148.17795953472;7161.4270858330165;7234.131904171533;7255.854882902418;7307.0135531702535;6997.7200911962955;7069.22238553769;7082.256363082009;7099;7143.4999550031;6360.522960777867;6451.870962580816;6492.610443373413;6504.414602685781;6509.316521765336;4931.580815630568;4945.530174633404;5020.347354843993;5062.493750624908;5163.948360516347;5006.123928312603;5046.949530504648;5130.973805238892;5139.6145289102715;5180.48195180494 09:11:37 INFO - PROCESS | 1637 | |4;prototype.html;329.44488536815476;352.7953786803654;358.92642008388276;365.1000284299202;371.5708356847842;5253.44838791927;5387.784488620456;5405.18922161676;5487.945120548793;5567.916481252784;5121.615878809085;5273.841784746454;5343.946560534394;5351.7056561889085;5361.7587208575615;4221.409002739619;4227.287948380911;4235.428217190686;4243.769306900995;4292.098659281554;3979.5622481527007;4051.4733084698946;4162.188373267214;4266.146770645868;4287.914241715163;3490;4164.708470407073;4181.393697913801;4197.977456231509;4232.978835105836;4191.937120943188;4192.281164722449;4194.433751443562;4221.620054195107;4242.703010789246;3711.46183803347;3713.9415266648875;3731.533558305212;3736.7010639148803;3783.243351329745;4201.432806571135;4959.603231741452;5050.6212034097225;5247.18971954675;5315.255864179018;4459.019015816515;4519.548045195487;4733.479317275097;4740.691855029412;4763.880902977418;5792.710364481801;5796.362654991968;5818.5054270386645;5826.737796799154;5827.446392592697;2822.9011984580443;3705.925881482382;3898.8830335089992;3921.9215615687526;3951.565327813938;6028.819135425944;6079.574429789872;6121.143039974407;6129.785457508966;6139.87720245597;3388.3562123196516;3619.932120024599;3897.395903634941;3966.3058964681063;3984.641382275551;3404.8978530643626;3901.0247438140464;3982.26328129297;4035.1929614077303;4046.806192173316;3784.4890939723336;4683.718976861399;4685.734851590051;4706.294055891643;4766.76166191689;5074.619403544749;5800.88398232033;5825.446582574648;5839.474447299764;5853.64878107315;1087.7770057138268;1230.8953738932112;1273.6179146256086;1280.4494067551043;1282.5318758653211;737.1375490675922;822.2805045585113;844.9831003379898;866.2030931542996;884.4030279561271;4915.058551872062;4984.003199360142;5019.623528235397;5037.924431133536;5062.569681577107;4846.552490992097;5451.882364115347;5610.691411972381;5702.832923489131;5736.311642602915;3998.320285551405;4384.693071484965;4532.750698711602;4754.5007774183905;4827.155247831615;2484.968737973757;2519.44572194117;2621.069520320259;2873.33913199961;2994.610700608907;4922.975385123052;5246.658967167122;5294.814681486129;5655.4910058094965;5918.704064796743;4776.922038913084;5315.149576067811;5425.2996215826315;5551.750171242304;5869.853253668693;5182.481751824787;5395.865103372447;5526.661570667007;5898.734556944948;5951.732172052268;5338.893222135458;5593.685998301548;5627.465390787868;5708.885822283614;5736.877355378537;5495.6153069284765;5669.958814826577;5909.497692696169;5955.940440595538;5986.2517185351835;5807.970960145172;6182.969085154546;6227.408396202353;6237.783632191679;6242.937570624235;3229.337985712876;3538.876139335111;3880.3791393376923;3980.164165525272;4027.026756889162;4264.381664658669;5388.865278368072;5515.365732940763;5887.470127688529;5887.646741195542;4708.835190768306;5610.961972035187;5625.521830644441;5751.073390414091;5763.049096898964;5290.7883684653725;5432.945670543244;5515.779368825202;5789.768409263583;5868.823935281948;5244.108501554669;5351.839444816662;5555.583331250254;5629.634073785191;5677.460641239076;4846.36997190363;4973.502649734997;5223.347081614798;5761.481466667852;5808.941910581009;4486.663500237561;4751.311059896227;5640.71796410186;5665.405132461197;5681.0626246668835 09:11:37 INFO - PROCESS | 1637 | |5;yui.html;661.2428769059424;706.5195666946474;723.1683563901516;732.4213871041876;819.7704642700044;14522.636934076654;16697.33210671573;17308.740368894447;17333.566660833487;17731.822681773177;16296.266667999938;16414;16437.342506299734;16446.095464749433;16525.66948661026;685.0170006041346;849.817289282804;881.2377293640986;886.9379143459961;890.3055616619048;702.5328156775738;842.7724514381114;858.4420126917491;873.6592728835759;882.7263548300048;923.2752289452781;930.860370944357;931.993447077155;932.6222879733684;938.6245501799301;925.842606756853;928.0487500312166;930.8557173638063;931.5435436636068;933.1135421349677;679.3546131175403;686.5606012152226;689.6517258784332;695.0130814243786;698.518022564434;14965.027273227315;15003.32485038165;15246.923765381212;15267.236638168159;15326;13836;13952.93023534886;14060;14116.082454640518;14139.080959737686;11633.987579124541;11903.702407439796;11906.107041971887;11934.701632459171;11947.761044779143;3591.102224443889;3666.4683620874825;3680.3191409589044;3719.4420836874415;3823.388257878754;105426.47286763594;108007.91992080057;109896;112296.87703122947;112780;10485.475726213659;10627.52176152075;10799.892001080047;10896.291741036806;10986.505607247693;17878.731819022723;22078.33764987053;22192;22310.776892231195;22313.44216394603;7635.809104772425;7653.15815260321;7744.883826742604;7776.261255180749;7785.922140778633;4036.273470775289;4127.071408933026;4129.545749967501;4131.938020929689;4137.069159439102;3622.166901612644;3709.684676802448;3709.8145092745253;3755.586885442599;3955.7033222508426;686.6429456682497;701.5545128843221;706.586646811621;716.9068021157216;726.5277569579815;582.5339728217409;634.638256193965;651.8077167235676;658.1575583253443;693.8855088910374;8810.849336370364;9237;10097.805449939677;10355.792884142274;10456.32033917793;580.8112363481886;588.6115163991744;589.3354102280402;594.4382558482192;600.6576251536669;4538.010065660769;4732.100900828831;4929.975350123226;5310.840050170143;5371.731413429313;88571;97468;101906.98093018975;106836.46581767041;109833.90166098396;78832;80359.39281214343;86059;89201.55399222963;90203.54898225467;72071.63964180251;76890;76965.6151719249;78336.2166378329;81520;9066.682666106655;10761;10762.838557421801;10794.352338859693;10949.233553651167;44274;46783;46878.76560617175;46896;51950;62065;65913.67043164754;67292;67785;69003.96494052492;13274.601761947157;13443.395047222702;13835.377408016864;14168.220747858966;14243.501477448239;14164.575062748134;14573.781393278898;15015.798736101304;15028.624284392978;15117.924410377878;12992.610221693365;13230.404631791786;13502.218990172405;13589.79615305791;14087.718245635235;13051.543195988095;13150.671233219246;13245.337733113498;13257.734845302846;13969.371378288204;12699.809502857279;13052.869471305165;13192.604221873358;13601.115927464683;13638.249896255802;10981.61564345244;11184.608538701106;11259.268147570381;11373.943130284295;11529.365884876412;10444.373337599769;10962.068224201032;11031.944840275748;11437.370944598128;11519.366434846164 09:11:37 INFO - PROCESS | 1637 | __end_tp_report 09:11:37 INFO - PROCESS | 1637 | __start_cc_report 09:11:37 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,379 09:11:37 INFO - PROCESS | 1637 | __end_cc_report 09:11:37 INFO - PROCESS | 1637 | __startTimestamp1486055497685__endTimestamp 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | ------- Summary: start ------- 09:11:37 INFO - PROCESS | 1637 | Number of tests: 6 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5740.88 Median:5987.58 stddev:668.42 (11.2%) stddev-sans-first:643.29 09:11:37 INFO - PROCESS | 1637 | Values: 3336.1 3352.2 3362.4 3382.7 3384.5 4482.0 4978.7 5451.6 5456.5 5720.7 5708.1 5712.1 5758.4 5782.2 5788.5 5245.2 5247.2 5265.2 5325.3 5326.9 5281.9 5307.9 5316.0 5320.3 5349.7 4388.7 5220.3 5302.5 5328.4 5332.3 5187.8 5203.8 5262.4 5262.7 5300.7 5108.2 5265.0 5289.4 5304.9 5322.7 5786.0 5822.1 5855.8 5900.9 5934.3 6120.8 6178.6 6178.8 6178.8 6292.1 6288.2 6305.9 6310.0 6311.9 6331.7 5910.0 5929.4 5931.6 5931.6 5987.6 6203.0 6240.6 6252.0 6271.2 6295.7 6129.0 6143.3 6227.0 6227.7 6230.7 6271.2 6272.0 6277.3 6294.4 6312.0 5308.9 6117.3 6129.7 6160.3 6265.4 6218.2 6248.1 6251.6 6304.8 6305.5 5006.2 5007.2 5018.9 5036.1 5043.7 4385.8 4504.1 4515.3 4522.1 4527.7 5759.8 5762.1 5781.5 5790.3 5902.1 6233.4 6297.7 6323.0 6323.8 6335.5 5660.4 5728.7 5782.5 5793.0 5816.6 4624.9 5457.1 5515.8 5515.9 5544.0 6350.6 6356.2 6372.1 6375.6 6391.6 6206.1 6262.4 6313.9 6314.8 6330.0 6260.2 6271.6 6298.7 6391.5 6411.1 6196.7 6238.8 6267.8 6277.7 6279.1 4802.5 4846.8 4940.9 6150.4 6176.2 6103.9 6112.3 6112.4 6196.8 6224.2 6194.2 6204.7 6208.9 6210.7 6240.6 5928.4 6022.7 6046.5 6055.0 6108.1 5965.1 6045.2 6114.5 6134.1 6153.1 5001.6 5973.0 6032.5 6044.1 6050.0 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:71014.92 Median:36277.91 stddev:155599.54 (428.9%) stddev-sans-first:155945.82 09:11:37 INFO - PROCESS | 1637 | Values: 443.9 446.0 477.0 490.5 491.1 27973.9 41471.8 41526.6 41646.8 41695.0 41817.0 42470.4 42574.4 42606.0 42606.4 8415.0 9232.2 9459.0 9463.8 9474.2 8449.0 9144.0 11180.3 11426.7 11555.2 11346.5 11385.4 11392.6 11398.7 11433.5 11370.2 11445.5 11456.8 11470.1 11507.7 11297.4 11340.9 11389.5 11394.4 11430.7 40701.6 40856.0 41161.0 41240.8 41319.8 4000.3 4007.1 4101.3 4105.0 4329.8 28736.3 29365.0 29385.0 31095.0 31708.0 3220.9 3236.4 3250.0 3334.7 3377.1 481265.0 489084.6 490338.0 490467.0 492451.0 52984.0 61580.4 61836.4 61939.0 63706.4 64356.0 65263.0 65309.7 65389.0 65585.7 16012.3 16561.0 16593.6 16599.3 16623.2 12231.0 12430.3 12495.1 12923.9 13055.0 18196.3 18380.8 18421.9 18449.6 18545.4 7812.6 7851.6 7886.1 7938.3 8000.5 874.8 887.3 894.3 900.2 930.7 25820.9 29348.4 30070.5 30631.4 31152.0 949.2 1016.2 1088.7 1090.9 1116.4 14508.4 15309.8 15347.3 15427.8 15823.3 557419.0 681145.0 682070.0 682144.0 685412.0 61788.0 62150.0 62286.0 62310.7 62540.7 1423.4 1438.8 1460.5 1463.7 1465.9 29250.7 30089.9 30232.4 30292.7 30443.1 51339.5 51423.0 51707.7 51914.5 51941.7 580552.0 584122.0 585189.0 587374.0 587422.1 23167.0 23864.4 25933.9 26758.7 26802.1 42666.6 46975.0 48108.0 48239.8 48796.0 35418.0 35983.0 36256.8 36261.0 36648.5 36030.6 36294.8 36575.0 36664.1 36953.4 35273.3 35416.8 35696.0 37097.3 37348.8 31526.4 32512.2 32683.8 32729.9 32922.5 24086.9 24572.5 24721.5 24998.4 25011.0 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:36665.45 Median:21784.84 stddev:104684.92 (480.5%) stddev-sans-first:104943.16 09:11:37 INFO - PROCESS | 1637 | Values: 394.8 395.2 397.0 400.9 422.4 19970.8 20970.0 21391.0 21410.0 21521.2 20706.0 20914.7 20961.8 21161.7 21374.4 5658.4 5944.9 5967.9 5971.0 5991.2 5501.8 5665.6 5771.0 5926.2 5938.3 5007.2 5797.8 5798.7 5801.7 5809.4 4072.9 5523.7 5544.6 5785.5 5810.1 5068.5 5081.1 5087.3 5087.4 5107.5 25546.7 25705.4 25851.0 25920.7 26146.2 3019.6 3047.6 3052.4 3080.8 3096.1 14907.6 15407.2 15446.4 15456.1 15750.4 1819.7 1821.5 1822.4 1847.0 1847.7 122498.0 126741.0 126794.4 127546.0 128159.1 10799.1 10941.6 11441.8 11535.7 11664.2 11889.9 14067.0 14162.4 14318.1 14357.6 7477.6 8105.5 8465.4 8697.3 8707.3 7168.6 8564.2 8595.6 8596.1 8621.7 6037.5 6948.9 6959.4 7070.3 7113.0 1662.3 1961.2 1985.7 1987.4 1989.7 1046.5 1070.3 1080.8 1105.6 1121.8 20705.4 21759.6 21778.0 21791.7 22032.3 953.9 1074.0 1105.5 1111.3 1124.6 11272.0 11522.5 11653.9 11675.1 11723.1 587249.0 602014.0 607555.0 654714.0 668960.0 114022.9 137630.3 143474.0 160020.0 166804.0 959.5 991.9 1041.6 1044.5 1045.9 18670.7 19092.0 19299.4 19335.8 19373.6 39213.4 54313.1 54344.2 57652.7 58677.7 56145.4 76887.6 82204.0 83671.0 84461.0 8087.8 8384.5 8414.0 8445.5 8473.1 8902.6 9602.7 11127.8 11897.5 13386.9 11376.2 11390.4 11457.9 11786.5 11909.9 11324.7 11487.4 11532.9 11837.7 11925.8 9824.5 11353.3 11447.4 12092.4 12130.2 8137.6 8322.4 8412.4 8463.7 8479.7 9429.1 11250.8 11545.8 11573.2 11655.5 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5423.73 Median:5183.80 stddev:2932.69 (56.6%) stddev-sans-first:2924.50 09:11:37 INFO - PROCESS | 1637 | Values: 1295.3 1421.6 1427.6 1432.8 1445.6 7512.7 7757.4 8097.1 8521.1 8531.0 7988.5 8278.5 8295.5 8367.2 8378.7 2308.6 2339.7 2340.7 2349.4 2360.5 1984.2 2065.2 2327.8 2360.3 2366.1 2203.3 2279.7 2280.5 2285.2 2287.8 2313.3 2315.0 2332.7 2341.6 2342.7 1980.0 2343.5 2356.7 2371.8 2380.6 8231.5 8441.6 8456.7 8462.4 8471.1 5086.5 5248.8 5258.1 5262.5 5290.6 3456.8 3474.0 3490.2 3525.8 3563.6 1206.2 1208.8 1257.9 1268.3 1271.6 10819.0 10899.1 10899.7 10900.8 10916.6 4344.6 4459.5 4682.5 4760.8 4767.8 8653.8 9543.6 9571.8 9580.6 9588.7 5187.1 5268.4 5272.6 5274.3 5306.9 4218.7 4528.3 4796.3 4812.1 4856.5 3884.3 3920.9 3931.5 3970.6 3993.1 1169.5 1200.0 1286.3 1286.6 1301.0 714.8 764.3 777.3 834.4 835.1 4973.0 5038.5 5221.5 5750.6 5867.8 942.3 993.8 996.4 1042.0 1042.5 3799.5 3890.7 3908.2 3961.2 4043.6 9581.9 9794.0 10117.9 10125.9 10182.4 9076.3 9144.4 9443.9 10080.6 10103.9 7491.5 7838.9 7853.3 7860.5 8023.8 4209.0 5260.0 5819.6 5885.5 5951.7 7755.0 8992.8 9111.1 9197.0 9312.6 8963.6 9266.2 9298.7 9321.5 9359.4 6804.2 6912.2 6963.6 6966.3 6985.4 7872.4 7891.3 7929.8 7948.0 7978.4 7148.2 7161.4 7234.1 7255.9 7307.0 6997.7 7069.2 7082.3 7099.0 7143.5 6360.5 6451.9 6492.6 6504.4 6509.3 4931.6 4945.5 5020.3 5062.5 5163.9 5006.1 5046.9 5131.0 5139.6 5180.5 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4566.48 Median:5056.60 stddev:1422.04 (28.1%) stddev-sans-first:1390.01 09:11:37 INFO - PROCESS | 1637 | Values: 329.4 352.8 358.9 365.1 371.6 5253.4 5387.8 5405.2 5487.9 5567.9 5121.6 5273.8 5343.9 5351.7 5361.8 4221.4 4227.3 4235.4 4243.8 4292.1 3979.6 4051.5 4162.2 4266.1 4287.9 3490.0 4164.7 4181.4 4198.0 4233.0 4191.9 4192.3 4194.4 4221.6 4242.7 3711.5 3713.9 3731.5 3736.7 3783.2 4201.4 4959.6 5050.6 5247.2 5315.3 4459.0 4519.5 4733.5 4740.7 4763.9 5792.7 5796.4 5818.5 5826.7 5827.4 2822.9 3705.9 3898.9 3921.9 3951.6 6028.8 6079.6 6121.1 6129.8 6139.9 3388.4 3619.9 3897.4 3966.3 3984.6 3404.9 3901.0 3982.3 4035.2 4046.8 3784.5 4683.7 4685.7 4706.3 4766.8 5074.6 5800.9 5825.4 5839.5 5853.6 1087.8 1230.9 1273.6 1280.4 1282.5 737.1 822.3 845.0 866.2 884.4 4915.1 4984.0 5019.6 5037.9 5062.6 4846.6 5451.9 5610.7 5702.8 5736.3 3998.3 4384.7 4532.8 4754.5 4827.2 2485.0 2519.4 2621.1 2873.3 2994.6 4923.0 5246.7 5294.8 5655.5 5918.7 4776.9 5315.1 5425.3 5551.8 5869.9 5182.5 5395.9 5526.7 5898.7 5951.7 5338.9 5593.7 5627.5 5708.9 5736.9 5495.6 5670.0 5909.5 5955.9 5986.3 5808.0 6183.0 6227.4 6237.8 6242.9 3229.3 3538.9 3880.4 3980.2 4027.0 4264.4 5388.9 5515.4 5887.5 5887.6 4708.8 5611.0 5625.5 5751.1 5763.0 5290.8 5432.9 5515.8 5789.8 5868.8 5244.1 5351.8 5555.6 5629.6 5677.5 4846.4 4973.5 5223.3 5761.5 5808.9 4486.7 4751.3 5640.7 5665.4 5681.1 09:11:37 INFO - PROCESS | 1637 | 09:11:37 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20420.60 Median:3714.63 stddev:29119.50 (783.9%) stddev-sans-first:29163.39 09:11:37 INFO - PROCESS | 1637 | Values: 661.2 706.5 723.2 732.4 819.8 14522.6 16697.3 17308.7 17333.6 17731.8 16296.3 16414.0 16437.3 16446.1 16525.7 685.0 849.8 881.2 886.9 890.3 702.5 842.8 858.4 873.7 882.7 923.3 930.9 932.0 932.6 938.6 925.8 928.0 930.9 931.5 933.1 679.4 686.6 689.7 695.0 698.5 14965.0 15003.3 15246.9 15267.2 15326.0 13836.0 13952.9 14060.0 14116.1 14139.1 11634.0 11903.7 11906.1 11934.7 11947.8 3591.1 3666.5 3680.3 3719.4 3823.4 105426.5 108007.9 109896.0 112296.9 112780.0 10485.5 10627.5 10799.9 10896.3 10986.5 17878.7 22078.3 22192.0 22310.8 22313.4 7635.8 7653.2 7744.9 7776.3 7785.9 4036.3 4127.1 4129.5 4131.9 4137.1 3622.2 3709.7 3709.8 3755.6 3955.7 686.6 701.6 706.6 716.9 726.5 582.5 634.6 651.8 658.2 693.9 8810.8 9237.0 10097.8 10355.8 10456.3 580.8 588.6 589.3 594.4 600.7 4538.0 4732.1 4930.0 5310.8 5371.7 88571.0 97468.0 101907.0 106836.5 109833.9 78832.0 80359.4 86059.0 89201.6 90203.5 72071.6 76890.0 76965.6 78336.2 81520.0 9066.7 10761.0 10762.8 10794.4 10949.2 44274.0 46783.0 46878.8 46896.0 51950.0 62065.0 65913.7 67292.0 67785.0 69004.0 13274.6 13443.4 13835.4 14168.2 14243.5 14164.6 14573.8 15015.8 15028.6 15117.9 12992.6 13230.4 13502.2 13589.8 14087.7 13051.5 13150.7 13245.3 13257.7 13969.4 12699.8 13052.9 13192.6 13601.1 13638.2 10981.6 11184.6 11259.3 11373.9 11529.4 10444.4 10962.1 11031.9 11437.4 11519.4 09:11:37 INFO - PROCESS | 1637 | -------- Summary: end -------- 09:11:37 INFO - PROCESS | 1637 | 09:11:38 INFO - TEST-INFO | 1637: exit 0 09:11:38 INFO - TEST-OK | dromaeo_css | took 1116184ms 09:11:38 INFO - TEST-START | kraken 09:11:38 INFO - operating with platform_type : mac_ 09:11:38 INFO - Initialising browser for kraken test... 09:11:38 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpa2tFyD/profile http://localhost:49241/getInfo.html) 09:11:41 INFO - PROCESS | 1648 | 2017-02-02 09:11:41.130 plugin-container[1649:9913] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 09:11:41 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:11:41 INFO - PROCESS | 1648 | 2017-02-02 09:11:41.133 plugin-container[1649:9913] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 09:11:41 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:11:41 INFO - PROCESS | 1648 | 2017-02-02 09:11:41.133 plugin-container[1649:9913] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:11:41 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:11:41 INFO - PROCESS | 1648 | colorDepth:24 09:11:41 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:11:41 INFO - PROCESS | 1648 | __metrics 09:11:41 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 09:11:41 INFO - TEST-INFO | 1648: exit 0 09:11:41 INFO - Browser initialized. 09:11:41 INFO - Running cycle 1/1 for kraken test... 09:11:41 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/T/tmpa2tFyD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:44 INFO - PROCESS | 1650 | 2017-02-02 09:11:44.271 plugin-container[1651:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 09:11:44 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:11:44 INFO - PROCESS | 1650 | 2017-02-02 09:11:44.272 plugin-container[1651:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4427, name = 'com.apple.CFPasteboardClient' 09:11:44 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:11:44 INFO - PROCESS | 1650 | 2017-02-02 09:11:44.272 plugin-container[1651:10044] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:11:53 INFO - PROCESS | 1650 | RSS: Main: 218558464 09:11:53 INFO - PROCESS | 1650 | 09:11:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:57 INFO - PROCESS | 1650 | RSS: Main: 232914944 09:11:57 INFO - PROCESS | 1650 | 09:12:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:12:01 INFO - PROCESS | 1650 | RSS: Main: 240795648 09:12:01 INFO - PROCESS | 1650 | 09:12:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:12:05 INFO - PROCESS | 1650 | RSS: Main: 244666368 09:12:05 INFO - PROCESS | 1650 | 09:12:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:12:07 INFO - PROCESS | 1650 | RSS: Main: 245493760 09:12:07 INFO - PROCESS | 1650 | 09:12:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:10 INFO - PROCESS | 1650 | RSS: Main: 246370304 09:12:10 INFO - PROCESS | 1650 | 09:12:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:13 INFO - PROCESS | 1650 | RSS: Main: 250372096 09:12:13 INFO - PROCESS | 1650 | 09:12:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:17 INFO - PROCESS | 1650 | RSS: Main: 249348096 09:12:17 INFO - PROCESS | 1650 | 09:12:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:12:21 INFO - PROCESS | 1650 | RSS: Main: 249528320 09:12:21 INFO - PROCESS | 1650 | 09:12:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:23 INFO - PROCESS | 1650 | RSS: Main: 248885248 09:12:23 INFO - PROCESS | 1650 | 09:12:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:26 INFO - PROCESS | 1650 | RSS: Main: 248913920 09:12:26 INFO - PROCESS | 1650 | 09:12:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:29 INFO - PROCESS | 1650 | RSS: Main: 248975360 09:12:29 INFO - PROCESS | 1650 | 09:12:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:32 INFO - PROCESS | 1650 | RSS: Main: 249348096 09:12:32 INFO - PROCESS | 1650 | 09:12:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:36 INFO - PROCESS | 1650 | RSS: Main: 249180160 09:12:36 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:12:38 INFO - PROCESS | 1650 | RSS: Main: 250978304 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | __start_tp_report 09:12:38 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:12:38 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:12:38 INFO - PROCESS | 1650 | |i|pagename|runs| 09:12:38 INFO - PROCESS | 1650 | |0;ai-astar;106;120;119;118;119;118;118;117;117;119 09:12:38 INFO - PROCESS | 1650 | |1;audio-beat-detection;148;140;103;179;145;102;145;135;161;144 09:12:38 INFO - PROCESS | 1650 | |2;audio-dft;198;198;200;196;194;193;253;276;196;195 09:12:38 INFO - PROCESS | 1650 | |3;audio-fft;82;59;59;84;59;59;62;58;71;55 09:12:38 INFO - PROCESS | 1650 | |4;audio-oscillator;85;73;85;72;69;73;80;70;59;91 09:12:38 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;136;75;137;134;89;99;89;85;88;87 09:12:38 INFO - PROCESS | 1650 | |6;imaging-darkroom;163;107;155;155;96;96;126;98;156;153 09:12:38 INFO - PROCESS | 1650 | |7;imaging-desaturate;94;79;142;146;92;91;91;93;93;94 09:12:38 INFO - PROCESS | 1650 | |8;json-parse-financial;59;58;60;63;63;63;62;68;89;97 09:12:38 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;69;75;71;82;78;74;70;96;104;94 09:12:38 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;87;85;88;84;85;83;87;84;85 09:12:38 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;138;135;145;153;155;141;146;152;190;154 09:12:38 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;170;171;167;170;165;168;168;173;168;170 09:12:38 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;77;82;88;89;90;83;67;74;87;87 09:12:38 INFO - PROCESS | 1650 | __end_tp_report 09:12:38 INFO - PROCESS | 1650 | __start_cc_report 09:12:38 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,933 09:12:38 INFO - PROCESS | 1650 | __end_cc_report 09:12:38 INFO - PROCESS | 1650 | __startTimestamp1486055558461__endTimestamp 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:12:38 INFO - PROCESS | 1650 | Number of tests: 14 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:117.10 Median:118.50 stddev:4.01 (3.4%) stddev-sans-first:1.00 09:12:38 INFO - PROCESS | 1650 | Values: 106.0 120.0 119.0 118.0 119.0 118.0 118.0 117.0 117.0 119.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:145.00 stddev:23.40 (16.1%) stddev-sans-first:24.65 09:12:38 INFO - PROCESS | 1650 | Values: 148.0 140.0 103.0 179.0 145.0 102.0 145.0 135.0 161.0 144.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:209.90 Median:198.00 stddev:29.35 (14.8%) stddev-sans-first:30.82 09:12:38 INFO - PROCESS | 1650 | Values: 198.0 198.0 200.0 196.0 194.0 193.0 253.0 276.0 196.0 195.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:64.80 Median:60.50 stddev:10.48 (17.3%) stddev-sans-first:9.08 09:12:38 INFO - PROCESS | 1650 | Values: 82.0 59.0 59.0 84.0 59.0 59.0 62.0 58.0 71.0 55.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.50 stddev:9.49 (12.4%) stddev-sans-first:9.45 09:12:38 INFO - PROCESS | 1650 | Values: 85.0 73.0 85.0 72.0 69.0 73.0 80.0 70.0 59.0 91.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:87.50 stddev:24.02 (27.4%) stddev-sans-first:22.08 09:12:38 INFO - PROCESS | 1650 | Values: 136.0 75.0 137.0 134.0 89.0 99.0 89.0 85.0 88.0 87.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:130.50 Median:159.50 stddev:28.72 (18.0%) stddev-sans-first:27.95 09:12:38 INFO - PROCESS | 1650 | Values: 163.0 107.0 155.0 155.0 96.0 96.0 126.0 98.0 156.0 153.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:92.50 stddev:22.84 (24.7%) stddev-sans-first:24.06 09:12:38 INFO - PROCESS | 1650 | Values: 94.0 79.0 142.0 146.0 92.0 91.0 91.0 93.0 93.0 94.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:63.00 stddev:13.49 (21.4%) stddev-sans-first:13.89 09:12:38 INFO - PROCESS | 1650 | Values: 59.0 58.0 60.0 63.0 63.0 63.0 62.0 68.0 89.0 97.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:76.50 stddev:12.39 (16.2%) stddev-sans-first:12.32 09:12:38 INFO - PROCESS | 1650 | Values: 69.0 75.0 71.0 82.0 78.0 74.0 70.0 96.0 104.0 94.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.66 09:12:38 INFO - PROCESS | 1650 | Values: 87.0 87.0 85.0 88.0 84.0 85.0 83.0 87.0 84.0 85.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:152.50 stddev:15.41 (10.1%) stddev-sans-first:15.62 09:12:38 INFO - PROCESS | 1650 | Values: 138.0 135.0 145.0 153.0 155.0 141.0 146.0 152.0 190.0 154.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.26 (1.3%) stddev-sans-first:2.37 09:12:38 INFO - PROCESS | 1650 | Values: 170.0 171.0 167.0 170.0 165.0 168.0 168.0 173.0 168.0 170.0 09:12:38 INFO - PROCESS | 1650 | 09:12:38 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.40 Median:87.00 stddev:7.55 (8.7%) stddev-sans-first:7.75 09:12:38 INFO - PROCESS | 1650 | Values: 77.0 82.0 88.0 89.0 90.0 83.0 67.0 74.0 87.0 87.0 09:12:38 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:12:38 INFO - PROCESS | 1650 | 09:12:39 INFO - TEST-INFO | 1650: exit 0 09:12:39 INFO - TEST-OK | kraken | took 61058ms 09:12:39 INFO - SUITE-END | took 1177s 09:12:39 INFO - Completed test suite (00:19:37) 09:12:39 INFO - javascript benchmark 09:12:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7356.650478840463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.0659015475676, 3352.2122301259205, 3362.394768941591, 3382.7124694400973, 3384.543086683297, 4481.955180448203, 4978.651494395389, 5451.618386712932, 5456.499462647774, 5720.685362305072, 5708.08670612702, 5712.1431785232235, 5758.3665796762325, 5782.161586569945, 5788.507976821965, 5245.213218017289, 5247.23915032321, 5265.236540701596, 5325.254464374991, 5326.920096198541, 5281.9207711884355, 5307.867303317409, 5316.043112239795, 5320.281761962144, 5349.652272602288, 4388.670849686287, 5220.347456567929, 5302.469753024686, 5328.440513746059, 5332.33345831771, 5187.766550505217, 5203.843884683465, 5262.394824595182, 5262.710550919698, 5300.734963251822, 5108.157154069574, 5265.0, 5289.418164001957, 5304.867378315535, 5322.65402748824, 5786.0, 5822.097574875858, 5855.76576936922, 5900.852478688024, 5934.317553481319, 6120.755169793203, 6178.598391104564, 6178.752849885999, 6178.752849885999, 6292.056191571301, 6288.151099601541, 6305.905411418832, 6310.0, 6311.8737625247695, 6331.68341582919, 5909.9704501477645, 5929.377415371367, 5931.58478906481, 5931.64410135389, 5987.5808693391045, 6203.0, 6240.563160578807, 6251.9687401562705, 6271.184745983084, 6295.685215739195, 6128.961487065963, 6143.327652471189, 6226.968865155736, 6227.719752611143, 6230.6573138476915, 6271.247450305992, 6272.0, 6277.340879207617, 6294.402031806971, 6311.96844015777, 5308.893822123536, 6117.296510901214, 6129.725578588854, 6160.260768707783, 6265.373462653698, 6218.22272215973, 6248.094026366151, 6251.624902505864, 6304.8423789404715, 6305.527085468608, 5006.249062640633, 5007.198848184273, 5018.949810501921, 5036.11867923112, 5043.722595257296, 4385.846495372647, 4504.099180163915, 4515.345274935182, 4522.140793249272, 4527.683062185615, 5759.798407055733, 5762.135679648086, 5781.508571771446, 5790.334111577138, 5902.1146827976145, 6233.376662333731, 6297.685115744194, 6323.0, 6323.841903952438, 6335.461485773669, 5660.377358490563, 5728.742206600713, 5782.479576838105, 5793.04414771558, 5816.5928385013485, 4624.907501849944, 5457.126859702428, 5515.779368825282, 5515.862103447446, 5544.002079625626, 6350.587211831216, 6356.2054743157105, 6372.0760489729655, 6375.585586936834, 6391.648459334781, 6206.06908963659, 6262.405071518198, 6313.936860631335, 6314.8317561251315, 6330.0, 6260.186175797299, 6271.560990730605, 6298.71655775482, 6391.520635952415, 6411.134496842867, 6196.721147548281, 6238.781642642486, 6267.811965641038, 6277.748890044347, 6279.058141278845, 4802.543758342952, 4846.830360937351, 4940.92588611164, 6150.384961503813, 6176.197094377702, 6103.877922441615, 6112.321110680095, 6112.388761123852, 6196.783112591038, 6224.221972253468, 6194.225721784777, 6204.658743768956, 6208.875822483616, 6210.720517576629, 6240.563160578898, 5928.36148059586, 6022.66875321844, 6046.455818976313, 6054.969725151346, 6108.114323423168, 5965.075413310944, 6045.244344456943, 6114.48026917717, 6134.11055396956, 6153.107799368977, 5001.57486613642, 5973.0, 6032.517398608013, 6044.123602077762, 6049.969750151221], "value": 5698.9172326274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.9367714324194, 446.0254344257795, 477.00544364998984, 490.51194061908404, 491.1208936004552, 27973.86013069937, 41471.79264103675, 41526.584734152646, 41646.791766041206, 41695.0, 41817.0, 42470.362944555854, 42574.36138457926, 42606.0, 42606.36090458646, 8415.0, 9232.215261702746, 9459.006804285555, 9463.81072378552, 9474.194693451065, 8448.957755211215, 9144.0, 11180.329180249171, 11426.71433214172, 11555.19113662044, 11346.546138154465, 11385.373804440753, 11392.601258955938, 11398.658040258806, 11433.485493152828, 11370.204085713962, 11445.542178312857, 11456.828147577793, 11470.082393408507, 11507.712307192303, 11297.378644174567, 11340.943295283554, 11389.487473063731, 11394.430278486125, 11430.71423214418, 40701.592984070376, 40856.0, 41160.97097572555, 41240.793796031125, 41319.7934010331, 4000.2599519089063, 4007.1184339445276, 4101.282275601788, 4105.014796448861, 4329.783510824446, 28736.281592960135, 29365.0, 29385.0, 31095.0, 31708.04875853705, 3220.9355812883846, 3236.449803533405, 3249.951250731241, 3334.749893757978, 3377.0713053910126, 481265.0, 489084.5545772284, 490338.0, 490467.0, 492450.9999999964, 52984.0, 61580.384196157465, 61836.38163618396, 61939.0, 63706.40733981688, 64356.0, 65263.0, 65309.67345163339, 65389.01916471257, 65585.67207164029, 16012.279447424893, 16561.0, 16593.585160371087, 16599.253033613517, 16623.168841558116, 12231.021518278516, 12430.316332601793, 12495.125341226209, 12923.935380323039, 13055.0, 18196.272149113887, 18380.816191838177, 18421.90789046046, 18449.631007379776, 18545.35091271799, 7812.648430820626, 7851.646675899598, 7886.067913361263, 7938.325242354349, 8000.479968802126, 874.8075423406967, 887.3123329419751, 894.2845723421237, 900.2213085680839, 930.7481437466597, 25820.870895645403, 29348.385838778646, 30070.54894176589, 30631.40314579845, 31152.0, 949.2358651285781, 1016.2022812092472, 1088.684281558355, 1090.9345439273668, 1116.430620383594, 14508.372906773307, 15309.770353444706, 15347.309371078329, 15427.768583471257, 15823.287952041956, 557419.0, 681145.0, 682070.0, 682144.0, 685412.0, 61788.0, 62150.0, 62286.0, 62310.688446558386, 62540.68729656414, 1423.4306277489088, 1438.8201474815648, 1460.5399299220712, 1463.7072585482947, 1465.8607432293916, 29250.707492924797, 30089.94685186008, 30232.395352092393, 30292.697073028987, 30443.11033462194, 51339.48660513347, 51423.0, 51707.741461292455, 51914.48085519097, 51941.7402912983, 580552.0, 584122.0, 585189.0, 587374.0, 587422.1257787539, 23167.0, 23864.403389914696, 25933.87033064898, 26758.732412675625, 26802.061927832434, 42666.57333426626, 46975.0, 48108.0, 48239.75880120577, 48796.024079518924, 35418.0, 35983.0, 36256.81871590625, 36261.0, 36648.45027324645, 36030.63969360273, 36294.8185259072, 36575.0, 36664.05113775516, 36953.44569831508, 35273.294534109686, 35416.822915885255, 35696.0, 37097.25805483821, 37348.81325593355, 31526.369472610877, 32512.187195320304, 32683.836580816944, 32729.85445509396, 32922.50616240806, 24086.87956560206, 24572.50854982926, 24721.50556988814, 24998.37504062413, 25011.0], "value": 20266.700656957688, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8321963165654, 395.1898607853899, 397.0332240993184, 400.8857475619449, 422.36223302812743, 19970.800291997075, 20970.0, 21391.03740331685, 21410.0, 21521.24675636353, 20705.96470176489, 20914.68627970578, 20961.790382096173, 21161.68257476139, 21374.358769236947, 5658.405867383927, 5944.910826337608, 5967.850803729898, 5971.044632858743, 5991.221141251631, 5501.752421141038, 5665.603407761459, 5770.961226979142, 5926.170336152921, 5938.317093534234, 5007.223880298559, 5797.797077102302, 5798.739056742456, 5801.709914504279, 5809.3609702932645, 4072.9389059164137, 5523.696196709159, 5544.556435485151, 5785.508231800281, 5810.1284807279035, 5068.467810879878, 5081.085404627165, 5087.313212716273, 5087.364079490064, 5107.514786095315, 25546.744532554807, 25705.357366065997, 25850.965961361522, 25920.74079259202, 26146.215613531433, 3019.5772591837163, 3047.6342838859478, 3052.3895220955897, 3080.7997480163717, 3096.071178646397, 14907.627309317246, 15407.152606606744, 15446.382144714198, 15456.072635641898, 15750.369985200578, 1819.7452356670076, 1821.5172979160534, 1822.3803906671662, 1846.9722954155698, 1847.7228415737613, 122498.0, 126741.0, 126794.36602816927, 127546.0, 128159.07761383493, 10799.082078023299, 10941.617043403443, 11441.828372574419, 11535.711607209887, 11664.183507154417, 11889.881101188877, 14067.0, 14162.433502659984, 14318.14091154534, 14357.6410589734, 7477.551346919202, 8105.473144245605, 8465.449745766506, 8697.304025714924, 8707.259882909897, 7168.641567921583, 8564.186402291773, 8595.5702214889, 8596.140385961478, 8621.69824056155, 6037.486813620892, 6948.861022779516, 6959.408450281681, 7070.328318809705, 7113.039739635186, 1662.2852173565484, 1961.205711686769, 1985.7120717495882, 1987.3839109875985, 1989.7365173115177, 1046.4610725476234, 1070.3356280982991, 1080.778440419712, 1105.6019832860163, 1121.7644294698205, 20705.378838634864, 21759.564808704054, 21778.0, 21791.67312490314, 22032.33902982913, 953.8506100149303, 1073.9892601073889, 1105.4914739219887, 1111.2998810749177, 1124.5614210457927, 11272.0, 11522.53909843597, 11653.941730291293, 11675.12436567261, 11723.062155027577, 587249.0, 602014.0, 607555.0, 654714.0, 668960.0, 114022.85977140289, 137630.31184844012, 143474.0, 160020.0, 166804.0, 959.5346257065318, 991.9404835709736, 1041.6250149946165, 1044.5038606661774, 1045.8849526552074, 18670.719939201193, 19092.045397730337, 19299.421017369503, 19335.8066419334, 19373.612527749647, 39213.41179882361, 54313.09904153336, 54344.18483722826, 57652.71173644105, 58677.70661146838, 56145.43854561402, 76887.61556192183, 82204.0, 83671.0, 84461.0, 8087.757367278991, 8384.53885036329, 8413.95793021031, 8445.535495547558, 8473.110323415953, 8902.59938302791, 9602.711918642452, 11127.777444451227, 11897.512810898637, 13386.866131338562, 11376.203665743318, 11390.37352945596, 11457.885421145682, 11786.469608867794, 11909.94045029804, 11324.660260192208, 11487.425628718363, 11532.88467115318, 11837.704057398634, 11925.821112683143, 9824.45965471906, 11353.318800871974, 11447.370394628042, 12092.39538023113, 12130.211536250115, 8137.552434616153, 8322.37582181351, 8412.411131220755, 8463.66145354179, 8479.745607631781, 9429.104942113781, 11250.7749845001, 11545.826812597987, 11573.18987670855, 11655.533778649098], "value": 9998.346513645016, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.339376917772, 1421.6232698334943, 1427.614544073101, 1432.8065711128995, 1445.64581677489, 7512.737054203104, 7757.418193635472, 8097.068837083737, 8521.147885211476, 8530.976282846068, 7988.520688758664, 8278.461899976512, 8295.543745094017, 8367.2469477747, 8378.664853405857, 2308.5844547981355, 2339.6841426407473, 2340.695709557755, 2349.3774149850306, 2360.4570948681812, 1984.2360691133945, 2065.215218217083, 2327.8021368183727, 2360.33910505058, 2366.1127077345996, 2203.2839327218717, 2279.6922415473946, 2280.4754906371545, 2285.223024171781, 2287.794098531132, 2313.3175713164655, 2314.9537009259807, 2332.685087513198, 2341.613633750421, 2342.695449591542, 1980.039680754847, 2343.4610039690797, 2356.658284548748, 2371.750966148547, 2380.5595964746576, 8231.506109633441, 8441.57792110392, 8456.704015359433, 8462.449940753831, 8471.068182499981, 5086.491350864921, 5248.81629142982, 5258.132408152688, 5262.473752624745, 5290.60320475962, 3456.792592444436, 3473.99254216277, 3490.225270909633, 3525.806080665562, 3563.55455568054, 1206.1858245684127, 1208.848893888264, 1257.8930790882694, 1268.346801397272, 1271.631226944185, 10819.0, 10899.12806975448, 10899.673009809718, 10900.781984360348, 10916.563337466492, 4344.56554344563, 4459.531749166355, 4682.484926658065, 4760.809567617326, 4767.76161191939, 8653.783655408664, 9543.61825526985, 9571.760705982268, 9580.56887440067, 9588.66439674608, 5187.118189907725, 5268.394134674485, 5272.630915835932, 5274.340707411574, 5306.9386122775595, 4218.6835987300465, 4528.275475923836, 4796.304535842283, 4812.133815913169, 4856.538628830326, 3884.31032500863, 3920.941185882214, 3931.4692516510477, 3970.5830887756947, 3993.0815912340327, 1169.497116240025, 1199.9820002699967, 1286.2604002698486, 1286.6075846866795, 1300.9917314081474, 714.8034290570134, 764.2853931573997, 777.2654841175035, 834.3742193354984, 835.1231207232503, 4972.950270497321, 5038.546530812171, 5221.530062294411, 5750.619851235673, 5867.823965281048, 942.3026960049514, 993.7726907269516, 996.4121168510613, 1041.9687409377732, 1042.4891803016467, 3799.4680744695765, 3890.708196885245, 3908.218356328689, 3961.207758448322, 4043.555208927016, 9581.856272155923, 9794.0, 10117.949410253048, 10125.898741012643, 10182.439965801952, 9076.319276054322, 9144.405613635092, 9443.866735991587, 10080.596776128872, 10103.898961010296, 7491.475596708287, 7838.921610783819, 7853.332466740277, 7860.489068210548, 8023.759287221276, 4209.0, 5260.0005998861625, 5819.592628516132, 5885.47030767233, 5951.732172052181, 7754.961225193838, 8992.775180620536, 9111.088891110836, 9197.0, 9312.627494900127, 8963.59663815143, 9266.166045055978, 9298.72103836886, 9321.50754018512, 9359.391639543408, 6804.21751498584, 6912.170539535288, 6963.582185068912, 6966.268541803038, 6985.371316581329, 7872.370210383041, 7891.250331218525, 7929.762107136795, 7947.960260198662, 7978.361731061617, 7148.17795953472, 7161.4270858330165, 7234.131904171533, 7255.854882902418, 7307.0135531702535, 6997.7200911962955, 7069.22238553769, 7082.256363082009, 7099.0, 7143.4999550031, 6360.522960777867, 6451.870962580816, 6492.610443373413, 6504.414602685781, 6509.316521765336, 4931.580815630568, 4945.530174633404, 5020.347354843993, 5062.493750624908, 5163.948360516347, 5006.123928312603, 5046.949530504648, 5130.973805238892, 5139.6145289102715, 5180.48195180494], "value": 4413.641294643928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.44488536815476, 352.7953786803654, 358.92642008388276, 365.1000284299202, 371.5708356847842, 5253.44838791927, 5387.784488620456, 5405.18922161676, 5487.945120548793, 5567.916481252784, 5121.615878809085, 5273.841784746454, 5343.946560534394, 5351.7056561889085, 5361.7587208575615, 4221.409002739619, 4227.287948380911, 4235.428217190686, 4243.769306900995, 4292.098659281554, 3979.5622481527007, 4051.4733084698946, 4162.188373267214, 4266.146770645868, 4287.914241715163, 3490.0, 4164.708470407073, 4181.393697913801, 4197.977456231509, 4232.978835105836, 4191.937120943188, 4192.281164722449, 4194.433751443562, 4221.620054195107, 4242.703010789246, 3711.46183803347, 3713.9415266648875, 3731.533558305212, 3736.7010639148803, 3783.243351329745, 4201.432806571135, 4959.603231741452, 5050.6212034097225, 5247.18971954675, 5315.255864179018, 4459.019015816515, 4519.548045195487, 4733.479317275097, 4740.691855029412, 4763.880902977418, 5792.710364481801, 5796.362654991968, 5818.5054270386645, 5826.737796799154, 5827.446392592697, 2822.9011984580443, 3705.925881482382, 3898.8830335089992, 3921.9215615687526, 3951.565327813938, 6028.819135425944, 6079.574429789872, 6121.143039974407, 6129.785457508966, 6139.87720245597, 3388.3562123196516, 3619.932120024599, 3897.395903634941, 3966.3058964681063, 3984.641382275551, 3404.8978530643626, 3901.0247438140464, 3982.26328129297, 4035.1929614077303, 4046.806192173316, 3784.4890939723336, 4683.718976861399, 4685.734851590051, 4706.294055891643, 4766.76166191689, 5074.619403544749, 5800.88398232033, 5825.446582574648, 5839.474447299764, 5853.64878107315, 1087.7770057138268, 1230.8953738932112, 1273.6179146256086, 1280.4494067551043, 1282.5318758653211, 737.1375490675922, 822.2805045585113, 844.9831003379898, 866.2030931542996, 884.4030279561271, 4915.058551872062, 4984.003199360142, 5019.623528235397, 5037.924431133536, 5062.569681577107, 4846.552490992097, 5451.882364115347, 5610.691411972381, 5702.832923489131, 5736.311642602915, 3998.320285551405, 4384.693071484965, 4532.750698711602, 4754.5007774183905, 4827.155247831615, 2484.968737973757, 2519.44572194117, 2621.069520320259, 2873.33913199961, 2994.610700608907, 4922.975385123052, 5246.658967167122, 5294.814681486129, 5655.4910058094965, 5918.704064796743, 4776.922038913084, 5315.149576067811, 5425.2996215826315, 5551.750171242304, 5869.853253668693, 5182.481751824787, 5395.865103372447, 5526.661570667007, 5898.734556944948, 5951.732172052268, 5338.893222135458, 5593.685998301548, 5627.465390787868, 5708.885822283614, 5736.877355378537, 5495.6153069284765, 5669.958814826577, 5909.497692696169, 5955.940440595538, 5986.2517185351835, 5807.970960145172, 6182.969085154546, 6227.408396202353, 6237.783632191679, 6242.937570624235, 3229.337985712876, 3538.876139335111, 3880.3791393376923, 3980.164165525272, 4027.026756889162, 4264.381664658669, 5388.865278368072, 5515.365732940763, 5887.470127688529, 5887.646741195542, 4708.835190768306, 5610.961972035187, 5625.521830644441, 5751.073390414091, 5763.049096898964, 5290.7883684653725, 5432.945670543244, 5515.779368825202, 5789.768409263583, 5868.823935281948, 5244.108501554669, 5351.839444816662, 5555.583331250254, 5629.634073785191, 5677.460641239076, 4846.36997190363, 4973.502649734997, 5223.347081614798, 5761.481466667852, 5808.941910581009, 4486.663500237561, 4751.311059896227, 5640.71796410186, 5665.405132461197, 5681.0626246668835], "value": 4117.8659312072705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.2428769059424, 706.5195666946474, 723.1683563901516, 732.4213871041876, 819.7704642700044, 14522.636934076654, 16697.33210671573, 17308.740368894447, 17333.566660833487, 17731.822681773177, 16296.266667999938, 16414.0, 16437.342506299734, 16446.095464749433, 16525.66948661026, 685.0170006041346, 849.817289282804, 881.2377293640986, 886.9379143459961, 890.3055616619048, 702.5328156775738, 842.7724514381114, 858.4420126917491, 873.6592728835759, 882.7263548300048, 923.2752289452781, 930.860370944357, 931.993447077155, 932.6222879733684, 938.6245501799301, 925.842606756853, 928.0487500312166, 930.8557173638063, 931.5435436636068, 933.1135421349677, 679.3546131175403, 686.5606012152226, 689.6517258784332, 695.0130814243786, 698.518022564434, 14965.027273227315, 15003.32485038165, 15246.923765381212, 15267.236638168159, 15326.0, 13836.0, 13952.93023534886, 14060.0, 14116.082454640518, 14139.080959737686, 11633.987579124541, 11903.702407439796, 11906.107041971887, 11934.701632459171, 11947.761044779143, 3591.102224443889, 3666.4683620874825, 3680.3191409589044, 3719.4420836874415, 3823.388257878754, 105426.47286763594, 108007.91992080057, 109896.0, 112296.87703122947, 112780.0, 10485.475726213659, 10627.52176152075, 10799.892001080047, 10896.291741036806, 10986.505607247693, 17878.731819022723, 22078.33764987053, 22192.0, 22310.776892231195, 22313.44216394603, 7635.809104772425, 7653.15815260321, 7744.883826742604, 7776.261255180749, 7785.922140778633, 4036.273470775289, 4127.071408933026, 4129.545749967501, 4131.938020929689, 4137.069159439102, 3622.166901612644, 3709.684676802448, 3709.8145092745253, 3755.586885442599, 3955.7033222508426, 686.6429456682497, 701.5545128843221, 706.586646811621, 716.9068021157216, 726.5277569579815, 582.5339728217409, 634.638256193965, 651.8077167235676, 658.1575583253443, 693.8855088910374, 8810.849336370364, 9237.0, 10097.805449939677, 10355.792884142274, 10456.32033917793, 580.8112363481886, 588.6115163991744, 589.3354102280402, 594.4382558482192, 600.6576251536669, 4538.010065660769, 4732.100900828831, 4929.975350123226, 5310.840050170143, 5371.731413429313, 88571.0, 97468.0, 101906.98093018975, 106836.46581767041, 109833.90166098396, 78832.0, 80359.39281214343, 86059.0, 89201.55399222963, 90203.54898225467, 72071.63964180251, 76890.0, 76965.6151719249, 78336.2166378329, 81520.0, 9066.682666106655, 10761.0, 10762.838557421801, 10794.352338859693, 10949.233553651167, 44274.0, 46783.0, 46878.76560617175, 46896.0, 51950.0, 62065.0, 65913.67043164754, 67292.0, 67785.0, 69003.96494052492, 13274.601761947157, 13443.395047222702, 13835.377408016864, 14168.220747858966, 14243.501477448239, 14164.575062748134, 14573.781393278898, 15015.798736101304, 15028.624284392978, 15117.924410377878, 12992.610221693365, 13230.404631791786, 13502.218990172405, 13589.79615305791, 14087.718245635235, 13051.543195988095, 13150.671233219246, 13245.337733113498, 13257.734845302846, 13969.371378288204, 12699.809502857279, 13052.869471305165, 13192.604221873358, 13601.115927464683, 13638.249896255802, 10981.61564345244, 11184.608538701106, 11259.268147570381, 11373.943130284295, 11529.365884876412, 10444.373337599769, 10962.068224201032, 11031.944840275748, 11437.370944598128, 11519.366434846164], "value": 7551.960122883604, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 119.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 119.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 140.0, 103.0, 179.0, 145.0, 102.0, 145.0, 135.0, 161.0, 144.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 200.0, 196.0, 194.0, 193.0, 253.0, 276.0, 196.0, 195.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 84.0, 59.0, 59.0, 62.0, 58.0, 71.0, 55.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 85.0, 72.0, 69.0, 73.0, 80.0, 70.0, 59.0, 91.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 75.0, 137.0, 134.0, 89.0, 99.0, 89.0, 85.0, 88.0, 87.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 107.0, 155.0, 155.0, 96.0, 96.0, 126.0, 98.0, 156.0, 153.0], "value": 130.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 79.0, 142.0, 146.0, 92.0, 91.0, 91.0, 93.0, 93.0, 94.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 60.0, 63.0, 63.0, 63.0, 62.0, 68.0, 89.0, 97.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 71.0, 82.0, 78.0, 74.0, 70.0, 96.0, 104.0, 94.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 88.0, 84.0, 85.0, 83.0, 87.0, 84.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 145.0, 153.0, 155.0, 141.0, 146.0, 152.0, 190.0, 154.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 167.0, 170.0, 165.0, 168.0, 168.0, 173.0, 168.0, 170.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 88.0, 89.0, 90.0, 83.0, 67.0, 74.0, 87.0, 87.0], "value": 82.4, "unit": "score"}]}]} 09:12:39 INFO - Return code: 0 09:12:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:39 ERROR - # TBPL SUCCESS # 09:12:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:39 INFO - 2017-02-02 09:12:39.744 screenresolution[1655:10426] starting screenresolution argv=screenresolution get 09:12:39 INFO - 2017-02-02 09:12:39.748 screenresolution[1655:10426] Display 0: 1600x1200x32@60 09:12:39 INFO - 2017-02-02 09:12:39.754 screenresolution[1656:10429] starting screenresolution argv=screenresolution list 09:12:39 INFO - Available Modes on Display 0 09:12:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:39 INFO - Intel Iris: 09:12:39 INFO - Chipset Model: Intel Iris 09:12:39 INFO - Type: GPU 09:12:39 INFO - Bus: Built-In 09:12:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:12:39 INFO - Vendor: Intel (0x8086) 09:12:39 INFO - Device ID: 0x0a2e 09:12:39 INFO - Revision ID: 0x0009 09:12:39 INFO - Displays: 09:12:39 INFO - Display: 09:12:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:39 INFO - Display Serial Number: 1600x1200 60 09:12:39 INFO - Main Display: Yes 09:12:39 INFO - Mirror: Off 09:12:39 INFO - Online: Yes 09:12:39 INFO - Rotation: Supported 09:12:39 INFO - Return code: 0 09:12:39 INFO - Running post-action listener: _resource_record_post_action 09:12:39 INFO - [mozharness: 2017-02-02 17:12:39.996425Z] Finished run-tests step (success) 09:12:39 INFO - Running post-run listener: _resource_record_post_run 09:12:40 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 38775296; Write bytes: 509744640; Read time: 243; Write time: 1607 09:12:40 INFO - TinderboxPrint: CPU usage
54.3% 09:12:40 INFO - TinderboxPrint: I/O read bytes / time
38,775,296 / 243 09:12:40 INFO - TinderboxPrint: I/O write bytes / time
509,744,640 / 1,607 09:12:40 INFO - TinderboxPrint: CPU idle
2,190.5 (45.7%) 09:12:40 INFO - TinderboxPrint: CPU system
963.2 (20.1%) 09:12:40 INFO - TinderboxPrint: CPU user
1,640.0 (34.2%) 09:12:40 INFO - TinderboxPrint: Swap in / out
246,493,184 / 0 09:12:40 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207407616; Write bytes: 198680576; Read time: 15907; Write time: 435 09:12:40 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35199488; Write bytes: 299968000; Read time: 219; Write time: 1136 09:12:40 INFO - Running post-run listener: _upload_blobber_files 09:12:40 INFO - Blob upload gear active. 09:12:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:12:40 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:12:40 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:12:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:12:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:42 INFO - (blobuploader) - INFO - Done attempting. 09:12:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:12:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:12:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:43 INFO - (blobuploader) - INFO - Done attempting. 09:12:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:12:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:44 INFO - (blobuploader) - INFO - Done attempting. 09:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:46 INFO - (blobuploader) - INFO - Done attempting. 09:12:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:46 INFO - Return code: 0 09:12:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a08fb62913bacc5f20b7910154cccd7e49aa4b881539a5048dd196385954d997991bbd904cfcdf6534e7bebcfdabf7bfcfb346631821a5a971d863e48f2e4fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4af54a2acd534b7498966325e6aa2edb0333e66a476c113dbc87f7b982976a9231a0f598edeccd4a0be55c2185084e0c7334faf0927a053d6ffa97efa2a3db48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ce34451e79edf1557a4a0e8a5242d9b8dce9aa480b9d6ad2c16fd961b8765aba9dbd500c34bbfb402fb3275cb42afded4e017819f1e797b4de48377571e577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/152f64dc071b2be7e799d7c2f2a5a4defda6cc9f6ac879d79e2ec7e6981b58b60366dfa4c6115daf9d527cc8e99f7800f1162926115ea04931079d9707c23734"} 09:12:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:46 INFO - Contents: 09:12:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a08fb62913bacc5f20b7910154cccd7e49aa4b881539a5048dd196385954d997991bbd904cfcdf6534e7bebcfdabf7bfcfb346631821a5a971d863e48f2e4fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4af54a2acd534b7498966325e6aa2edb0333e66a476c113dbc87f7b982976a9231a0f598edeccd4a0be55c2185084e0c7334faf0927a053d6ffa97efa2a3db48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ce34451e79edf1557a4a0e8a5242d9b8dce9aa480b9d6ad2c16fd961b8765aba9dbd500c34bbfb402fb3275cb42afded4e017819f1e797b4de48377571e577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/152f64dc071b2be7e799d7c2f2a5a4defda6cc9f6ac879d79e2ec7e6981b58b60366dfa4c6115daf9d527cc8e99f7800f1162926115ea04931079d9707c23734"} 09:12:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:46 INFO - Copying logs to upload dir... 09:12:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.687786 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-02 09:12:46.558560) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 09:12:46.561803) ========= 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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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/Mozilla-Aurora/sha512/9a08fb62913bacc5f20b7910154cccd7e49aa4b881539a5048dd196385954d997991bbd904cfcdf6534e7bebcfdabf7bfcfb346631821a5a971d863e48f2e4fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4af54a2acd534b7498966325e6aa2edb0333e66a476c113dbc87f7b982976a9231a0f598edeccd4a0be55c2185084e0c7334faf0927a053d6ffa97efa2a3db48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ce34451e79edf1557a4a0e8a5242d9b8dce9aa480b9d6ad2c16fd961b8765aba9dbd500c34bbfb402fb3275cb42afded4e017819f1e797b4de48377571e577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/152f64dc071b2be7e799d7c2f2a5a4defda6cc9f6ac879d79e2ec7e6981b58b60366dfa4c6115daf9d527cc8e99f7800f1162926115ea04931079d9707c23734"} build_url:https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010903 build_url: 'https://queue.taskcluster.net/v1/task/JxNev1D3QGyeZ_TuVz0BOA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a08fb62913bacc5f20b7910154cccd7e49aa4b881539a5048dd196385954d997991bbd904cfcdf6534e7bebcfdabf7bfcfb346631821a5a971d863e48f2e4fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4af54a2acd534b7498966325e6aa2edb0333e66a476c113dbc87f7b982976a9231a0f598edeccd4a0be55c2185084e0c7334faf0927a053d6ffa97efa2a3db48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86ce34451e79edf1557a4a0e8a5242d9b8dce9aa480b9d6ad2c16fd961b8765aba9dbd500c34bbfb402fb3275cb42afded4e017819f1e797b4de48377571e577", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/152f64dc071b2be7e799d7c2f2a5a4defda6cc9f6ac879d79e2ec7e6981b58b60366dfa4c6115daf9d527cc8e99f7800f1162926115ea04931079d9707c23734"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 09:12:46.596186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:12:46.596572) ========= 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.NWK5Xsv2Rl/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.CuHRSM6z2y/Listeners TMPDIR=/var/folders/_4/5kgy7ct120n7q2p9437gq4mw00000w/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.005423 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 09:12:46.645809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 09:12:46.646224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 09:12:46.646615) ========= ========= Total master_lag: 0.18 =========