builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0361 starttime: 1491903897.3 results: success (0) buildid: 20170411011520 builduid: 2974988e596242bfa1900de09c6b6fb4 revision: 596ea55fa962caa18ff1a5761fdccc58ef6a289c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.296022) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.296991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.297708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.324081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.324846) ========= 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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-11 02:44:57-- 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% 5.93M=0.002s 2017-04-11 02:44:57 (5.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077819 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.431151) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.431883) ========= 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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.021507 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:57.485028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 02:44:57.485801) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 596ea55fa962caa18ff1a5761fdccc58ef6a289c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 596ea55fa962caa18ff1a5761fdccc58ef6a289c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KCTK4vdOg8/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.dQVUYhOfsb/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-11 02:44:57,601 truncating revision to first 12 chars 2017-04-11 02:44:57,602 Setting DEBUG logging. 2017-04-11 02:44:57,602 attempt 1/10 2017-04-11 02:44:57,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/596ea55fa962?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 02:44:59,017 unpacking tar archive at: mozilla-central-596ea55fa962/testing/mozharness/ program finished with exit code 0 elapsedTime=1.690882 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-11 02:44:59.204390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:59.205183) ========= script_repo_revision: 596ea55fa962caa18ff1a5761fdccc58ef6a289c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:59.206140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:59.206847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 02:44:59.228265) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-11 02:44:59.228783) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KCTK4vdOg8/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.dQVUYhOfsb/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:44:59 INFO - MultiFileLogger online at 20170411 02:44:59 in /builds/slave/test 02:44:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:44:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:59 INFO - {'append_to_log': False, 02:44:59 INFO - 'base_work_dir': '/builds/slave/test', 02:44:59 INFO - 'blob_upload_branch': 'Firefox', 02:44:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:59 INFO - 'branch': 'Firefox', 02:44:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:59 INFO - 'config_files': ('talos/mac_config.py',), 02:44:59 INFO - 'default_actions': ('clobber', 02:44:59 INFO - 'read-buildbot-config', 02:44:59 INFO - 'download-and-extract', 02:44:59 INFO - 'populate-webroot', 02:44:59 INFO - 'create-virtualenv', 02:44:59 INFO - 'install', 02:44:59 INFO - 'run-tests'), 02:44:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:59 INFO - 'download_minidump_stackwalk': True, 02:44:59 INFO - 'download_symbols': 'ondemand', 02:44:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:44:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:44:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:44:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:44:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:59 INFO - 'gecko_profile': False, 02:44:59 INFO - 'gecko_profile_interval': 0, 02:44:59 INFO - 'installer_path': 'installer.exe', 02:44:59 INFO - 'log_level': 'info', 02:44:59 INFO - 'log_name': 'talos', 02:44:59 INFO - 'log_to_console': True, 02:44:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:44:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:44:59 INFO - 'opt_config_files': (), 02:44:59 INFO - 'pip_index': False, 02:44:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:59 INFO - 'cmd': ('bash', 02:44:59 INFO - '-c', 02:44:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:59 INFO - 'enabled': True, 02:44:59 INFO - 'halt_on_failure': False, 02:44:59 INFO - 'name': 'check_screen_resolution'},), 02:44:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:59 INFO - 'cmd': ('bash', 02:44:59 INFO - '-c', 02:44:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:59 INFO - 'enabled': True, 02:44:59 INFO - 'halt_on_failure': False, 02:44:59 INFO - 'name': 'check_screen_resolution'},), 02:44:59 INFO - 'run_cmd_checks_enabled': True, 02:44:59 INFO - 'suite': 'dromaeojs-e10s', 02:44:59 INFO - 'system_bits': '32', 02:44:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:59 INFO - 'title': 't-yosemite-r7-0361', 02:44:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:59 INFO - 'use_talos_json': True, 02:44:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:59 INFO - 'work_dir': 'build'} 02:44:59 INFO - [mozharness: 2017-04-11 09:44:59.454143Z] Running clobber step. 02:44:59 INFO - Running pre-action listener: _resource_record_pre_action 02:44:59 INFO - Running main action method: clobber 02:44:59 INFO - rmtree: /builds/slave/test/build 02:44:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:00 INFO - Running post-action listener: _resource_record_post_action 02:45:00 INFO - [mozharness: 2017-04-11 09:45:00.130116Z] Finished clobber step (success) 02:45:00 INFO - [mozharness: 2017-04-11 09:45:00.130256Z] Running read-buildbot-config step. 02:45:00 INFO - Running pre-action listener: _resource_record_pre_action 02:45:00 INFO - Running main action method: read_buildbot_config 02:45:00 INFO - Using buildbot properties: 02:45:00 INFO - { 02:45:00 INFO - "project": "", 02:45:00 INFO - "product": "firefox", 02:45:00 INFO - "script_repo_revision": "production", 02:45:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:45:00 INFO - "repository": "", 02:45:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:45:00 INFO - "buildid": "20170411011520", 02:45:00 INFO - "pgo_build": "False", 02:45:00 INFO - "basedir": "/builds/slave/test", 02:45:00 INFO - "buildnumber": 29, 02:45:00 INFO - "slavename": "t-yosemite-r7-0361", 02:45:00 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:45:00 INFO - "platform": "yosemite_r7", 02:45:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:45:00 INFO - "branch": "mozilla-central", 02:45:00 INFO - "repo_path": "mozilla-central", 02:45:00 INFO - "revision": "596ea55fa962caa18ff1a5761fdccc58ef6a289c", 02:45:00 INFO - "stage_platform": "macosx64", 02:45:00 INFO - "builduid": "2974988e596242bfa1900de09c6b6fb4", 02:45:00 INFO - "slavebuilddir": "test" 02:45:00 INFO - } 02:45:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:45:00 INFO - Running post-action listener: _resource_record_post_action 02:45:00 INFO - [mozharness: 2017-04-11 09:45:00.133660Z] Finished read-buildbot-config step (success) 02:45:00 INFO - [mozharness: 2017-04-11 09:45:00.133796Z] Running download-and-extract step. 02:45:00 INFO - Running pre-action listener: _resource_record_pre_action 02:45:00 INFO - Running main action method: download_and_extract 02:45:00 INFO - mkdir: /builds/slave/test/build/tests 02:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:00 INFO - trying https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:45:00 INFO - Downloading https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 02:45:01 INFO - Downloaded 1325 bytes. 02:45:01 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:45:01 INFO - Using the following test package requirements: 02:45:01 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:45:01 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:45:01 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:45:01 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:45:01 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'jsshell-mac.zip'], 02:45:01 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:45:01 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:45:01 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:45:01 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:45:01 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:45:01 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:45:01 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:45:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:45:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:45:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:45:01 INFO - Fetch https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:45:03 INFO - Expected file size: 52581293 02:45:03 INFO - Obtained file size: 52581293 02:45:19 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:45:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:45:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:45:19 INFO - Fetch https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:45:21 INFO - Expected file size: 52581293 02:45:21 INFO - Obtained file size: 52581293 02:45:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:45:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:45:36 INFO - Fetch https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:45:38 INFO - Expected file size: 14405596 02:45:38 INFO - Obtained file size: 14405596 02:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:38 INFO - trying https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:45:38 INFO - Downloading https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 02:45:40 INFO - Downloaded 70929317 bytes. 02:45:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:45:40 INFO - mkdir: /builds/slave/test/properties 02:45:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:40 INFO - Contents: 02:45:40 INFO - build_url:https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:45:41 INFO - Running post-action listener: _resource_record_post_action 02:45:41 INFO - Running post-action listener: set_extra_try_arguments 02:45:41 INFO - [mozharness: 2017-04-11 09:45:41.558436Z] Finished download-and-extract step (success) 02:45:41 INFO - [mozharness: 2017-04-11 09:45:41.558593Z] Running populate-webroot step. 02:45:41 INFO - Running pre-action listener: _resource_record_pre_action 02:45:41 INFO - Running main action method: populate_webroot 02:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:41 INFO - '--tppagecycles', 02:45:41 INFO - '7'], 02:45:41 INFO - 'tests': ['tsvgm']}}, 02:45:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:45:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:45:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:45:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:45:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['damp', 'tps']}, 02:45:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'tests': ['damp', 'tps']}, 02:45:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['dromaeo_dom']}, 02:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['basic_compositor_video']}, 02:45:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:45:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other-e10s': {'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['a11yr', 02:45:41 INFO - 'ts_paint', 02:45:41 INFO - 'tpaint', 02:45:41 INFO - 'sessionrestore', 02:45:41 INFO - 'sessionrestore_no_auto_restore', 02:45:41 INFO - 'tabpaint']}, 02:45:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tsvgx', 02:45:41 INFO - 'tsvgr_opacity', 02:45:41 INFO - 'tart', 02:45:41 INFO - 'tscrollx', 02:45:41 INFO - 'cart', 02:45:41 INFO - 'tsvg_static']}, 02:45:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:45:41 INFO - 'tsvgr_opacity', 02:45:41 INFO - 'tart', 02:45:41 INFO - 'tscrollx', 02:45:41 INFO - 'cart', 02:45:41 INFO - 'tsvg_static']}, 02:45:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s'], 02:45:41 INFO - 'tests': ['tp5o']}, 02:45:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:45:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'talos_options': ['--disable-e10s', 02:45:41 INFO - '--xperf_path', 02:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:41 INFO - 'tests': ['tp5n']}, 02:45:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:45:41 INFO - 'talos_options': ['--xperf_path', 02:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:41 INFO - 'tests': ['tp5n']}}, 02:45:41 INFO - 'talos.zip': {'path': '', 02:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:41 INFO - Running post-action listener: _resource_record_post_action 02:45:41 INFO - [mozharness: 2017-04-11 09:45:41.577413Z] Finished populate-webroot step (success) 02:45:41 INFO - [mozharness: 2017-04-11 09:45:41.577521Z] Running create-virtualenv step. 02:45:41 INFO - Running pre-action listener: _resource_record_pre_action 02:45:41 INFO - Running main action method: create_virtualenv 02:45:41 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:41 INFO - Using real prefix '/tools/python27' 02:45:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:42 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:45 INFO - Installing pip.................done. 02:45:45 INFO - Return code: 0 02:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:45:45 INFO - Reading from file tmpfile_stdout 02:45:45 INFO - Output received: 02:45:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:45:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:45 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:45 INFO - 'HOME': '/Users/cltbld', 02:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:45 INFO - 'LOGNAME': 'cltbld', 02:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:45 INFO - 'MOZ_NO_REMOTE': '1', 02:45:45 INFO - 'NO_EM_RESTART': '1', 02:45:45 INFO - 'PAGER': '/bin/cat', 02:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:45 INFO - 'PWD': '/builds/slave/test', 02:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:45 INFO - 'SHELL': '/bin/bash', 02:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:45:45 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:45 INFO - 'USER': 'cltbld', 02:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:45 INFO - 'XPC_FLAGS': '0x0', 02:45:45 INFO - 'XPC_SERVICE_NAME': '0', 02:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:45:45 INFO - Cleaning up... 02:45:45 INFO - Return code: 0 02:45:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:45 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:45:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:45 INFO - 'HOME': '/Users/cltbld', 02:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:45 INFO - 'LOGNAME': 'cltbld', 02:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:45 INFO - 'MOZ_NO_REMOTE': '1', 02:45:45 INFO - 'NO_EM_RESTART': '1', 02:45:45 INFO - 'PAGER': '/bin/cat', 02:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:45 INFO - 'PWD': '/builds/slave/test', 02:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:45 INFO - 'SHELL': '/bin/bash', 02:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:45:45 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:45 INFO - 'USER': 'cltbld', 02:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:45 INFO - 'XPC_FLAGS': '0x0', 02:45:45 INFO - 'XPC_SERVICE_NAME': '0', 02:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:46 INFO - Downloading/unpacking psutil>=3.1.1 02:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:49 INFO - Installing collected packages: psutil 02:45:49 INFO - Running setup.py install for psutil 02:45:49 INFO - building 'psutil._psutil_osx' extension 02:45:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:45:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:45:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:45:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:45:50 INFO - building 'psutil._psutil_posix' extension 02:45:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:45:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:45:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:45:50 INFO - ^ 02:45:50 INFO - 1 warning generated. 02:45:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:45:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:50 INFO - Successfully installed psutil 02:45:50 INFO - Cleaning up... 02:45:50 INFO - Return code: 0 02:45:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:50 INFO - 'HOME': '/Users/cltbld', 02:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:50 INFO - 'LOGNAME': 'cltbld', 02:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:50 INFO - 'MOZ_NO_REMOTE': '1', 02:45:50 INFO - 'NO_EM_RESTART': '1', 02:45:50 INFO - 'PAGER': '/bin/cat', 02:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:50 INFO - 'PWD': '/builds/slave/test', 02:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:50 INFO - 'SHELL': '/bin/bash', 02:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:45:50 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:50 INFO - 'USER': 'cltbld', 02:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:50 INFO - 'XPC_FLAGS': '0x0', 02:45:50 INFO - 'XPC_SERVICE_NAME': '0', 02:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:45:53 INFO - Installing collected packages: mozsystemmonitor 02:45:53 INFO - Running setup.py install for mozsystemmonitor 02:45:53 INFO - Successfully installed mozsystemmonitor 02:45:53 INFO - Cleaning up... 02:45:53 INFO - Return code: 0 02:45:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:54 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:54 INFO - 'HOME': '/Users/cltbld', 02:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:54 INFO - 'LOGNAME': 'cltbld', 02:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:54 INFO - 'MOZ_NO_REMOTE': '1', 02:45:54 INFO - 'NO_EM_RESTART': '1', 02:45:54 INFO - 'PAGER': '/bin/cat', 02:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:54 INFO - 'PWD': '/builds/slave/test', 02:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:54 INFO - 'SHELL': '/bin/bash', 02:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:45:54 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:54 INFO - 'USER': 'cltbld', 02:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:54 INFO - 'XPC_FLAGS': '0x0', 02:45:54 INFO - 'XPC_SERVICE_NAME': '0', 02:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:54 INFO - Downloading/unpacking jsonschema==2.5.1 02:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:45:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:45:58 INFO - warning: no files found matching '*.txt' 02:45:58 INFO - no previously-included directories found matching 'build' 02:45:58 INFO - no previously-included directories found matching 'dist' 02:45:58 INFO - no previously-included directories found matching '.git*' 02:45:58 INFO - Installing collected packages: jsonschema, functools32 02:45:58 INFO - Running setup.py install for functools32 02:45:58 INFO - warning: no files found matching '*.txt' 02:45:58 INFO - no previously-included directories found matching 'build' 02:45:58 INFO - no previously-included directories found matching 'dist' 02:45:58 INFO - no previously-included directories found matching '.git*' 02:45:58 INFO - Successfully installed jsonschema functools32 02:45:58 INFO - Cleaning up... 02:45:58 INFO - Return code: 0 02:45:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:58 INFO - 'HOME': '/Users/cltbld', 02:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:58 INFO - 'LOGNAME': 'cltbld', 02:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:58 INFO - 'MOZ_NO_REMOTE': '1', 02:45:58 INFO - 'NO_EM_RESTART': '1', 02:45:58 INFO - 'PAGER': '/bin/cat', 02:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:58 INFO - 'PWD': '/builds/slave/test', 02:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:58 INFO - 'SHELL': '/bin/bash', 02:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:45:58 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:58 INFO - 'USER': 'cltbld', 02:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:58 INFO - 'XPC_FLAGS': '0x0', 02:45:58 INFO - 'XPC_SERVICE_NAME': '0', 02:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:45:58 INFO - Cleaning up... 02:45:58 INFO - Return code: 0 02:45:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:58 INFO - 'HOME': '/Users/cltbld', 02:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:58 INFO - 'LOGNAME': 'cltbld', 02:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:58 INFO - 'MOZ_NO_REMOTE': '1', 02:45:58 INFO - 'NO_EM_RESTART': '1', 02:45:58 INFO - 'PAGER': '/bin/cat', 02:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:58 INFO - 'PWD': '/builds/slave/test', 02:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:58 INFO - 'SHELL': '/bin/bash', 02:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:45:58 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:58 INFO - 'USER': 'cltbld', 02:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:58 INFO - 'XPC_FLAGS': '0x0', 02:45:58 INFO - 'XPC_SERVICE_NAME': '0', 02:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:02 INFO - Downloading docopt-0.6.1.tar.gz 02:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:03 INFO - Running setup.py install for blobuploader 02:46:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:03 INFO - Running setup.py install for requests 02:46:03 INFO - Running setup.py install for docopt 02:46:03 INFO - Successfully installed blobuploader requests docopt 02:46:03 INFO - Cleaning up... 02:46:03 INFO - Return code: 0 02:46:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:03 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:03 INFO - 'HOME': '/Users/cltbld', 02:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:03 INFO - 'LOGNAME': 'cltbld', 02:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:03 INFO - 'MOZ_NO_REMOTE': '1', 02:46:03 INFO - 'NO_EM_RESTART': '1', 02:46:03 INFO - 'PAGER': '/bin/cat', 02:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:03 INFO - 'PWD': '/builds/slave/test', 02:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:03 INFO - 'SHELL': '/bin/bash', 02:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:46:03 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:03 INFO - 'USER': 'cltbld', 02:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:03 INFO - 'XPC_FLAGS': '0x0', 02:46:03 INFO - 'XPC_SERVICE_NAME': '0', 02:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-hbzkbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-dOSXTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-U48JRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-xjk_hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-pBeKpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-iGtP1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-yauZzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:04 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-Vzhne9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-qjIbC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ay6ZJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ak66YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-FrYEbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-e8fWin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-aI6bK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-g8Qpm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-eWtfCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:05 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-f7orZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:05 INFO - Running setup.py install for manifestparser 02:46:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:06 INFO - Running setup.py install for mozcrash 02:46:06 INFO - Running setup.py install for mozdebug 02:46:06 INFO - Running setup.py install for mozdevice 02:46:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:06 INFO - Running setup.py install for mozfile 02:46:06 INFO - Running setup.py install for mozhttpd 02:46:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:06 INFO - Running setup.py install for mozinfo 02:46:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:06 INFO - Running setup.py install for mozInstall 02:46:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Running setup.py install for mozleak 02:46:07 INFO - Running setup.py install for mozlog 02:46:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Running setup.py install for moznetwork 02:46:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Running setup.py install for mozprocess 02:46:07 INFO - Running setup.py install for mozprofile 02:46:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:07 INFO - Running setup.py install for mozrunner 02:46:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Running setup.py install for mozscreenshot 02:46:08 INFO - Running setup.py install for moztest 02:46:08 INFO - Running setup.py install for mozversion 02:46:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:08 INFO - Cleaning up... 02:46:08 INFO - Return code: 0 02:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:08 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:08 INFO - 'HOME': '/Users/cltbld', 02:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:08 INFO - 'LOGNAME': 'cltbld', 02:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:08 INFO - 'MOZ_NO_REMOTE': '1', 02:46:08 INFO - 'NO_EM_RESTART': '1', 02:46:08 INFO - 'PAGER': '/bin/cat', 02:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:08 INFO - 'PWD': '/builds/slave/test', 02:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:08 INFO - 'SHELL': '/bin/bash', 02:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:46:08 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:08 INFO - 'USER': 'cltbld', 02:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:08 INFO - 'XPC_FLAGS': '0x0', 02:46:08 INFO - 'XPC_SERVICE_NAME': '0', 02:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:08 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-sZRBhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:08 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-uY9XpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-7R5Oow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-C1TPkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-kOqc9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-Uf3fCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-LjLpfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-7wz3D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6xuGs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-hCdGZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-deiOky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:09 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-JC8HtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:10 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-4kvRLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:10 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-9sVLqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:10 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6RrTkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:10 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-01HIL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:10 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-g9YeaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:13 INFO - Downloading blessings-1.6.tar.gz 02:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:13 INFO - Installing collected packages: blessings 02:46:13 INFO - Running setup.py install for blessings 02:46:13 INFO - Successfully installed blessings 02:46:13 INFO - Cleaning up... 02:46:13 INFO - Return code: 0 02:46:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:13 INFO - Reading from file tmpfile_stdout 02:46:13 INFO - Current package versions: 02:46:13 INFO - blessings == 1.6 02:46:13 INFO - blobuploader == 1.2.4 02:46:13 INFO - docopt == 0.6.1 02:46:13 INFO - functools32 == 3.2.3-2 02:46:13 INFO - jsonschema == 2.5.1 02:46:13 INFO - manifestparser == 1.1 02:46:13 INFO - mozInstall == 1.12 02:46:13 INFO - mozcrash == 1.0 02:46:13 INFO - mozdebug == 0.1 02:46:13 INFO - mozdevice == 0.50 02:46:13 INFO - mozfile == 1.2 02:46:13 INFO - mozhttpd == 0.7 02:46:13 INFO - mozinfo == 0.9 02:46:13 INFO - mozleak == 0.1 02:46:13 INFO - mozlog == 3.4 02:46:13 INFO - moznetwork == 0.27 02:46:13 INFO - mozprocess == 0.25 02:46:13 INFO - mozprofile == 0.28 02:46:13 INFO - mozrunner == 6.13 02:46:13 INFO - mozscreenshot == 0.1 02:46:13 INFO - mozsystemmonitor == 0.3 02:46:13 INFO - moztest == 0.8 02:46:13 INFO - mozversion == 1.4 02:46:13 INFO - psutil == 3.1.1 02:46:13 INFO - requests == 1.2.3 02:46:13 INFO - wsgiref == 0.1.2 02:46:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:13 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:13 INFO - 'HOME': '/Users/cltbld', 02:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:13 INFO - 'LOGNAME': 'cltbld', 02:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:13 INFO - 'MOZ_NO_REMOTE': '1', 02:46:13 INFO - 'NO_EM_RESTART': '1', 02:46:13 INFO - 'PAGER': '/bin/cat', 02:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:13 INFO - 'PWD': '/builds/slave/test', 02:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:13 INFO - 'SHELL': '/bin/bash', 02:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:46:13 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:13 INFO - 'USER': 'cltbld', 02:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:13 INFO - 'XPC_FLAGS': '0x0', 02:46:13 INFO - 'XPC_SERVICE_NAME': '0', 02:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:46:14 INFO - Cleaning up... 02:46:14 INFO - Return code: 0 02:46:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:14 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 0x103628b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10362b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafb9e6bd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, '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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:14 INFO - 'HOME': '/Users/cltbld', 02:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:14 INFO - 'LOGNAME': 'cltbld', 02:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:14 INFO - 'MOZ_NO_REMOTE': '1', 02:46:14 INFO - 'NO_EM_RESTART': '1', 02:46:14 INFO - 'PAGER': '/bin/cat', 02:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:14 INFO - 'PWD': '/builds/slave/test', 02:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:14 INFO - 'SHELL': '/bin/bash', 02:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:46:14 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:14 INFO - 'USER': 'cltbld', 02:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:14 INFO - 'XPC_FLAGS': '0x0', 02:46:14 INFO - 'XPC_SERVICE_NAME': '0', 02:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:14 INFO - Cleaning up... 02:46:14 INFO - Return code: 0 02:46:14 INFO - Running post-action listener: _resource_record_post_action 02:46:14 INFO - Running post-action listener: _start_resource_monitoring 02:46:14 INFO - Starting resource monitoring. 02:46:14 INFO - [mozharness: 2017-04-11 09:46:14.428791Z] Finished create-virtualenv step (success) 02:46:14 INFO - [mozharness: 2017-04-11 09:46:14.429801Z] Running install step. 02:46:14 INFO - Running pre-action listener: _resource_record_pre_action 02:46:14 INFO - Running main action method: install 02:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:14 INFO - Reading from file tmpfile_stdout 02:46:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:14 INFO - Reading from file tmpfile_stdout 02:46:14 INFO - Output received: 02:46:14 INFO - Usage: mozinstall [options] installer 02:46:14 INFO - Options: 02:46:14 INFO - -h, --help show this help message and exit 02:46:14 INFO - -d DEST, --destination=DEST 02:46:14 INFO - Directory to install application into. [default: 02:46:14 INFO - "/builds/slave/test"] 02:46:14 INFO - --app=APP Application being installed. [default: firefox] 02:46:14 INFO - mkdir: /builds/slave/test/build/application 02:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:46:34 INFO - Reading from file tmpfile_stdout 02:46:34 INFO - Output received: 02:46:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:46:34 INFO - Running post-action listener: _resource_record_post_action 02:46:34 INFO - [mozharness: 2017-04-11 09:46:34.296552Z] Finished install step (success) 02:46:34 INFO - [mozharness: 2017-04-11 09:46:34.296735Z] Running run-tests step. 02:46:34 INFO - Running pre-action listener: _resource_record_pre_action 02:46:34 INFO - Running main action method: run_tests 02:46:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:34 INFO - 2017-04-11 02:46:34.311 screenresolution[6928:132672] starting screenresolution argv=screenresolution get 02:46:34 INFO - 2017-04-11 02:46:34.314 screenresolution[6928:132672] Display 0: 1600x1200x32@60 02:46:34 INFO - 2017-04-11 02:46:34.320 screenresolution[6929:132675] starting screenresolution argv=screenresolution list 02:46:34 INFO - Available Modes on Display 0 02:46:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:34 INFO - Intel Iris: 02:46:34 INFO - Chipset Model: Intel Iris 02:46:34 INFO - Type: GPU 02:46:34 INFO - Bus: Built-In 02:46:34 INFO - VRAM (Dynamic, Max): 1536 MB 02:46:34 INFO - Vendor: Intel (0x8086) 02:46:34 INFO - Device ID: 0x0a2e 02:46:34 INFO - Revision ID: 0x0009 02:46:34 INFO - Displays: 02:46:34 INFO - Display: 02:46:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:34 INFO - Display Serial Number: 1600x1200 60 02:46:34 INFO - Main Display: Yes 02:46:34 INFO - Mirror: Off 02:46:34 INFO - Online: Yes 02:46:34 INFO - Rotation: Supported 02:46:34 INFO - Return code: 0 02:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:34 INFO - Python 2.7.3 02:46:34 INFO - Return code: 0 02:46:34 INFO - grabbing minidump binary from tooltool 02:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:34 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 0x103406d30>, '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 0x10332ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033fbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:46:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:46:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:46:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:34 INFO - Return code: 0 02:46:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:46:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:34 INFO - ENV: RUST_BACKTRACE is now 1 02:46:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:46:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0361 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCTK4vdOg8/Render', 02:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:34 INFO - 'HOME': '/Users/cltbld', 02:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:34 INFO - 'LOGNAME': 'cltbld', 02:46:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:34 INFO - 'MOZ_NO_REMOTE': '1', 02:46:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:34 INFO - 'NO_EM_RESTART': '1', 02:46:34 INFO - 'PAGER': '/bin/cat', 02:46:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:34 INFO - 'PWD': '/builds/slave/test', 02:46:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:34 INFO - 'RUST_BACKTRACE': '1', 02:46:34 INFO - 'SHELL': '/bin/bash', 02:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dQVUYhOfsb/Listeners', 02:46:34 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 02:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:34 INFO - 'USER': 'cltbld', 02:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:34 INFO - 'XPC_FLAGS': '0x0', 02:46:34 INFO - 'XPC_SERVICE_NAME': '0', 02:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:46:34 INFO - mozversion application_buildid: 20170411011520 02:46:34 INFO - mozversion application_changeset: 596ea55fa962caa18ff1a5761fdccc58ef6a289c 02:46:34 INFO - mozversion application_display_name: Nightly 02:46:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:34 INFO - mozversion application_name: Firefox 02:46:34 INFO - mozversion application_remotingname: firefox 02:46:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:46:34 INFO - mozversion application_vendor: Mozilla 02:46:34 INFO - mozversion application_version: 55.0a1 02:46:34 INFO - mozversion platform_buildid: 20170411011520 02:46:34 INFO - mozversion platform_changeset: 596ea55fa962caa18ff1a5761fdccc58ef6a289c 02:46:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:46:34 INFO - mozversion platform_version: 55.0a1 02:46:34 INFO - using testdate: 1491903994 02:46:34 INFO - actual date: 1491903994 02:46:34 INFO - starting webserver on 'localhost:61909' 02:46:34 INFO - SUITE-START | Running 2 tests 02:46:34 INFO - TEST-START | dromaeo_css 02:46:34 INFO - operating with platform_type : mac_ 02:46:34 INFO - Initialising browser for dromaeo_css test... 02:46:34 INFO - TEST-INFO | started process 6939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpvODRVU/profile http://localhost:61909/getInfo.html) 02:46:37 INFO - PID 6939 | 2017-04-11 02:46:37.876 plugin-container[6941:132852] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 02:46:37 INFO - PID 6939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:46:37 INFO - PID 6939 | 2017-04-11 02:46:37.878 plugin-container[6941:132852] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 02:46:37 INFO - PID 6939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:46:37 INFO - PID 6939 | 2017-04-11 02:46:37.878 plugin-container[6941:132852] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:46:37 INFO - PID 6939 | __metrics Screen width/height:1600/1200 02:46:37 INFO - PID 6939 | colorDepth:24 02:46:37 INFO - PID 6939 | Browser inner width/height: 1024/689 02:46:37 INFO - PID 6939 | __metrics 02:46:38 ERROR - PID 6939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 02:46:38 INFO - TEST-INFO | 6939: exit 0 02:46:38 INFO - Browser initialized. 02:46:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:38 INFO - TEST-INFO | started process 6942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpvODRVU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:41 INFO - PID 6942 | 2017-04-11 02:46:41.691 plugin-container[6943:132987] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 02:46:41 INFO - PID 6942 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:46:41 INFO - PID 6942 | 2017-04-11 02:46:41.691 plugin-container[6943:132987] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 02:46:41 INFO - PID 6942 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:46:41 INFO - PID 6942 | 2017-04-11 02:46:41.691 plugin-container[6943:132987] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:46:51 INFO - PID 6942 | RSS: Main: 235364352 02:46:51 INFO - PID 6942 | 02:49:55 INFO - PID 6942 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61909/tests/dromaeo/cssquery-ext.html) 02:49:56 INFO - PID 6942 | RSS: Main: 253833216 02:49:56 INFO - PID 6942 | 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | A coding exception was thrown and uncaught in a Task. 02:51:39 INFO - PID 6942 | 02:51:39 ERROR - PID 6942 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:51:39 INFO - PID 6942 | Full stack: 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | A coding exception was thrown and uncaught in a Task. 02:51:39 INFO - PID 6942 | 02:51:39 ERROR - PID 6942 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:51:39 INFO - PID 6942 | Full stack: 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | A coding exception was thrown and uncaught in a Task. 02:51:39 INFO - PID 6942 | 02:51:39 ERROR - PID 6942 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:51:39 INFO - PID 6942 | Full stack: 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | ************************* 02:51:39 INFO - PID 6942 | A coding exception was thrown and uncaught in a Task. 02:51:39 INFO - PID 6942 | 02:51:39 ERROR - PID 6942 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:51:39 INFO - PID 6942 | Full stack: 02:51:39 INFO - PID 6942 | ************************* 02:52:58 INFO - PID 6942 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-ext.html (next: http://localhost:61909/tests/dromaeo/cssquery-jquery.html) 02:52:59 INFO - PID 6942 | RSS: Main: 261140480 02:52:59 INFO - PID 6942 | 02:56:01 INFO - PID 6942 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61909/tests/dromaeo/cssquery-mootools.html) 02:56:01 INFO - PID 6942 | RSS: Main: 275447808 02:56:01 INFO - PID 6942 | 02:59:03 INFO - PID 6942 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61909/tests/dromaeo/cssquery-prototype.html) 02:59:04 INFO - PID 6942 | RSS: Main: 267747328 02:59:04 INFO - PID 6942 | 03:02:07 INFO - PID 6942 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61909/tests/dromaeo/cssquery-yui.html) 03:02:07 INFO - PID 6942 | RSS: Main: 277987328 03:02:07 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-yui.html (next: http://localhost:61909/tests/dromaeo/cssquery-dojo.html) 03:05:09 INFO - PID 6942 | RSS: Main: 271917056 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | __start_tp_report 03:05:09 INFO - PID 6942 | _x_x_mozilla_page_load 03:05:09 INFO - PID 6942 | _x_x_mozilla_page_load_details 03:05:09 INFO - PID 6942 | |i|pagename|runs| 03:05:09 INFO - PID 6942 | |0;dojo.html;2991.282092297849;3366.713829324509;3519.2961407718453;3547.2018795770937;3572.2498275362173;6102.943731970943;6153.138560601514;6154.969225153879;6192;6214.906776398347;4826.913944362516;6119.9595720210555;6123.892747182678;6140.508759299268;6251;5407.756650950697;5444.591655625824;5454.59090568207;5512.862178445551;5537.750801213935;5398.676079435227;5461.15352120422;5514.172874068881;5526.115821468566;5541.695206763647;5354.41101478837;5397.838064858021;5456.372517160498;5468.234447177399;5498.752556134984;5444.564434845203;5446.428125046892;5468.043092458804;5468.890622187574;5525.060739674265;5379.919301210485;5400.540954018913;5408.621396502246;5426.213199086111;5473.808416705436;5987.161797348374;6071.696415179224;6121.361519882465;6156.6921653917125;6156.96921515394;6681.665916704145;6734.663266836638;6749.527533072687;6755.763548275787;6758.560693554952;6816.454683625348;6841.2132604750595;6849.452043836481;6865.450763938873;6866.519343645947;6200.689965501752;6258.812235632939;6259.061140828912;6278.372162783685;6329.177206963065;6956;6961.93038069623;6996.8950465743055;7003.124609423822;7016.087908571853;6347.174867267226;6434.0670602763275;6494.577852439671;6589.9341006590275;6691.899621505681;5578;6620.5365624406795;6669.599824010478;6795.864082718318;6909.965450172717;6402.103705481236;6537.477001839841;6705.664716764142;6709.932900671029;6723.596584204865;5556.82597758979;6600.73597056122;6602.1747281589805;6633.1376920999965;6702.932970670328;5368.087425137736;5368.2752828367675;5368.91946620801;5380;5417.18742188667;4720.173969555314;4791.0178413425165;4816.638752093607;4835.057163853015;4846.224604063404;5911.349751527328;6209.534284928648;6278.246610406781;6367.745290188341;6423.775167869196;6845.315468453115;6861.1080559526945;6868.62222577753;6869.896951545731;6884.48366372514;5805.419458054245;6300.117983482224;6398.168238129014;6412.775552855627;6414.711337989708;5789.8552536186935;5865.472107510344;5883;5900.1739756434135;5903.793367232212;6754.155730533684;6834.760783372658;6876.381125698511;6889.242183359726;6942.965285173542;6762.830929226612;6835.624040677811;6844.8973265402055;6855.006024126374;6867.107276054081;6889.793306200822;6947.374736273558;6952.5480843745;6964.477664175106;6970.372666460043;6426.839329016812;6520.836979075561;6614.900776488453;6635.535512514078;6695.4308883745425;5964.403559644001;6490;6771.593704377753;6817.659117044227;6820.658967051727;6415.454686351713;6511.2512061113575;6603.688708951829;6610.4711623071;6634.867302654016;6557.868842623026;6568.244651865097;6575.5725877819705;6584.374484423972;6601.768938087336;6237.407446292595;6253.843653908689;6306.936930630818;6352.301246862934;6366.236051673829;6583.341665833378;6625.900611490735;6643.435307998874;6643.56816806906;6644.468442524683;6431.549791514549;6446.387593178828;6458.806235812933;6476.996065609838;6484.1246431731115 03:05:09 INFO - PID 6942 | |1;ext.html;635.3043417457883;744.8752383900312;827.0902007791428;1270.7649084919285;1277.1953669188404;38260.617393826054;38935;38952.41571376432;38995.61004389955;39060.60939390605;38913.805430972876;39247.80376098116;39309;39396.80301598495;39463.60536394642;8014.5992700364895;8116.6347514362;8520.744377668649;8735.956320218422;8782.868256976119;8649.567521623925;8690.95708514979;8728.734333521636;8755.95622021889;8769.95615021924;8719.389642725011;8764.43031202973;8774;8782.516961567111;8790.47257164569;7237.240089790549;7275.927240727631;8740.213380795727;8760.474371537728;8766.123387661246;8556.229939305493;8619.956900215459;8623.568821558896;8632.13678632138;8637.309015278826;30067;37687.62312376869;37968.05079872998;38018;38051.238975220615;3549.538559987211;3585.8924232273075;3585.982070089659;3599.046252743025;3610.4042832932537;30781;30873.691263087305;30884;30939.535906961413;30978.84510577455;3138.246820763023;3160.984195079033;3169.683031696835;3175.872965081394;3198.824064676442;166164.16917915453;261448.07827882597;276641;297977.6516761252;299027;43176.784116079216;49069.26396104061;49427.50572494229;49534.50465495371;49538.25692614542;50980.490195097576;51453.48546514487;51470.713232169495;51571.45285641362;51781.223281650804;14388.640283992774;14457.277136143151;14497.710045799025;14523.201223932574;14529.128252304896;11975.46110425033;12056.698582535506;12057.57798477049;12059.939700301618;12067;13513.121647093105;13516.594502164951;13576.049676522549;13581.185128892299;13623.863761362458;5892.823215303548;5900.675462849498;5933.673647949404;5937.198478205473;5950.821475355746;1035.6530562261726;1054.984175237372;1056.8626078609732;1082.1234799812178;1086.4567716141928;23697.7630223699;24660.753392465846;24687.02503799692;24902;24984.875680594418;1127.3912087472836;1130.649498655403;1161.454116565213;1163.8196079607674;1169.4912712969715;11058.834117488244;11114.277571957797;12163.14857959952;12747.61757147287;12753.48986040548;354312;355758;356496;356690.2165489156;356795;47370.52629473661;53926.921461571335;55891.44108558944;56050;56282.43717562854;1510.358097808449;1549.511903750315;1585.47679265842;1587.1508742822534;1602.198900549725;24331.63502547428;24469.75530244675;24504.387390315384;24557.38606534851;24608.630870537316;35960.100997475274;35967.460488092176;40086.79739607817;40282;50894.491055088976;296733;298238;298649;299741;300333;29985.151410615956;30595.388092237587;34282.48576271408;35186;35300.29399412049;43834;43853.56146438622;44620.77689611531;44779;45158.32262516131;30131;30389.392212156075;30411.54382684217;31203.063908082793;31226.21934451657;25353.746462535877;29949.101526954226;30553.847230763702;30845.8457707719;30916.917907873118;35861.28277434489;36551.45172822463;36709.44935826018;36840.44739328966;36858;24475.75524244806;25841.70791460457;29192.686329114815;29532.852335738186;31864.681353187098;21863.344099677037;22108.88945555262;23928.88035559811;24271;24441.51116977686 03:05:09 INFO - PID 6942 | |2;jquery.html;439.25984715753975;445.7325604637217;446.1567637165757;460.2199272233563;465.00952970173523;21529.24647637333;22241.955599900226;22657.773422265793;23081.653775193387;23144.178644253236;20382;23153.421164470896;23517.76482235177;23826;24125.03499860008;6138.570300078996;6235.719392627343;6247.531435142359;6351.49188064956;6398.328175541571;6219.564630475868;6282.780102696406;6330.145430366911;6336.049592561107;6355.809325720235;6016.217891674076;6282.9685851570675;6321.715522801485;6333.55665103443;6337.081123237128;5991.2510936132985;6241.687915604201;6289.1509646197865;6339.080833279195;6354.68226588671;5621.241132447109;5637.943620563824;5643.351014633328;5643.492085712305;5656.123300888327;27652.30869228265;27666.170014899584;28797.85601072002;28814.423711525862;28953.276168095756;2242.159190303636;2272.0457407888725;2306.0199415248453;2310.653401989698;2310.7111611048617;14037.929810350985;17342;17438.651226975515;17624.559386015324;18310.633787324314;2104.7684754676975;2192.506685995654;2214.147553192033;2229.3646310801505;2229.721284839395;165726.1713691436;169264;169596;169991.99999999878;171264;10321.535530901128;11137.05335046514;12408.317542535247;12870.485180592672;12908.677283067811;16614;16756.83243167577;16775.496735097968;16786.66426671484;16800.579985500215;9029.909700903037;9273.258139348836;9302.953485232665;9302.976672566012;9416.90583094174;8909;8915.55422228886;8924.107589241154;8948.463092214488;9068;7915.683372665144;8047.235512626291;8075.434719569574;8095.676172953016;8103.513789172668;2175.19517778423;2177.911044477761;2178.7603363629987;2180.269609680743;2314.3635500237233;833.258400023967;951.8857737071596;953.1707414549248;985.7387792235063;1022.5602990714065;20248.797512024692;20780.480487987923;20894.582108358052;21144;21207.68188477174;893.8748575199477;1006.2955930848435;1016.7900198763448;1032.5198782566142;1041.0994489766297;9851.211903047739;10999.61501347449;11057.557697692002;11068.944655276671;11094.722631934104;684052;685655;687063;692274;724626;133537;146612;156668.43331566767;161482;164054;1094.7974624694457;1183.7810005149074;1199.2684462477882;1217.6468824040928;1260.4706023470164;19254.807451925302;20235.898820505805;22702.65946010778;22710.545789084455;22752.772472275727;62762;63022.36977630165;63741;64427.67786161227;64694;88044;88341;90295;90371.54814225886;90786.54606726924;8797.780055498664;8879.511626860585;8893;9012.909870901207;9026.18764311215;12015.939920300343;12970.870291297344;13668.043236973317;13865.4453821846;14272.785908211177;10955.34267943926;11845.11161662896;11899.631542372392;11980.520779168735;12009.939950300193;8888.422252553562;11076.446177690923;11116.722081948015;11327.32036077838;11496.540138394705;11673.474693638977;11754.353510557;12016.75966480683;12057.336846473529;12209.877901221229;8756.299496040428;8899.73300800977;8907.376483646083;8931.642734290815;8951;10351.223658225512;11031.613893513688;11942.820857686967;11983.101267405154;12012.879871201176 03:05:09 INFO - PID 6942 | |3;mootools.html;1178.7819253438113;1183.1599564309345;1424.430227908837;1431.584840396285;1476.4094362255096;9399.483028433433;11404.885951140486;11893.940530297346;11941.98493128084;12235.265884046963;11822.527098916054;11977.640670779869;12026.218295810788;12061.577844775435;12089.758204835898;2486.875656217191;2519.8866051027658;2531.5822889223255;2536.2391282615235;2537.581299085649;2436.9512609747794;2472.888720007595;2517.7985761139157;2523.823332366735;2531.2153232497985;2465.103503383526;2487.6890388701413;2489.8132640051977;2514.245726282117;2519.6472493850874;2423.6364545318256;2481.2060140754966;2483.4412257242066;2491.1281051631963;2500.6999160100722;2367.4318163640773;2481.0695989004125;2481.6029435290448;2494.8128890333296;2496.7378425265447;11916.285022898654;11962;11987.861153190433;11997.580084697081;12014.159008869383;6580.309067547886;6821;6827.48793840464;6843.178818541757;6862.730394876914;4058.391241313797;4313.547077556843;4314.935275970863;4390.056137930328;4419.292913133883;1250.1748845761754;1253.931033793141;1272.1540175783093;1285.9292738899358;1296.5008471738354;13413.46346146153;16317.184140792913;16408.6718265634;16448.259828307753;16614.92003019812;4762.904741905142;4768.523147685204;4847.394075740533;6163.691815409212;6219.787141507453;12763.872361276268;13737.175769453865;14036.438542458187;14040.929795350958;14057.648558786112;6760.121184246016;6775.661216939134;6782.966085169642;6828.112345395067;6829.214640316427;4986.301917731448;5847.619904706181;6140.4473597376455;6194.34959329273;6202.100695399142;4502.662300327489;4657.69724967876;4733.763311834395;4771.904561908743;4775;1448.9058211216238;1481.2965090146201;1481.6814384907082;1505.2925125191143;1523.0404844947834;784.7253461288503;796.1322158846884;818.1205204405288;824.3446460064263;848.1264297773304;6269.632923264688;6700.195976482853;6870.27862074485;6927.965360173167;6942.93057069433;577.2524580668045;578.7916350113956;596.4453058655405;621.1862460177182;625.1997443272618;3487.2502411981545;4171.124063946544;4370.2570563004365;4448.354988526646;4453.576910193591;14843.109413435228;15167.317470713844;15199.848001519844;15216.923915380574;15217.695646087017;14431.49489767853;14962.625934351729;14991.775123373158;15101.546953591409;15116.09303441797;9195.908040919505;10583.5237414315;10863.67408977732;10873.456327183609;10883.564657413774;6294.8111556653375;6769.424598909148;7119;7175.677094530654;7181.353678168781;10313.896861031593;12338.75322493563;12556.748865022832;12763.553275635679;12795.808062878878;12834.29411382383;12852.357382131044;12861.228326300452;12868.420921058387;13019;9524.476153811329;9735.123838854537;9735.1725103367;9737.17234035115;9761;10647.680569582924;10799.838002429813;10868.67393978182;10908.181886358396;10913.727156821144;9265.166135047879;9276.304277179104;9294.953525232331;9415.15263626277;9486.288528360263;8170.591470426574;8520.977482702116;9136.95431522838;9203;9305.720828375159;8172.223638754309;8183.3862460316905;8219.671213151407;8280.461769984931;8287.212714792086;5128.538431541179;5843.7954671587995;6035.1249068885645;6117.816465506042;6275.152854364603;4949.505049495022;4953.554180123806;5762.732198916232;6125.877482450415;6391.2330520336 03:05:09 INFO - PID 6942 | |4;prototype.html;305.83637753801713;397.8150160175519;398.5735263268304;405.76668415660964;413.41501774988393;5299.708516031616;5878.853028674274;6168.290646575645;6218.440340369366;6263.749450021999;5280.867978300545;5920.496757775594;6031.909521357183;6078.5441091918065;6115.41903519166;4018.97990510047;4587.977060114695;4594;4608;4609.285560738091;4085.1829634073156;4612.907741845161;4617.191991401508;4627.190241707688;4641.350210970467;4301.376300436435;4346.76092814895;4526.434195725535;4595.126925884088;4640.67515273931;4517.837513740395;4537.052764095259;4552.203364411214;4566.680332376735;4616.39986801717;3522.7710198836994;4012.959870401288;4053.3312003519386;4061.187762447493;4073.5926407359325;5017.297578339036;5229.398619158807;5603.299587551556;5952.9107063394085;5957.702114894281;5119.488051194888;5339.973300133474;5347.075052980924;5354.759035843396;5363.463653634644;5705.657660540381;6574.638394888279;6615.669216539154;6617.900731489031;6634.402903738638;4174.749515029078;4205.810738516774;4348.21732088224;4399.780010999437;4399.934000989988;5798.927198468297;6636.402723754837;6885.518013739041;6952.558483550675;6957.5129740918155;4081.77550234734;4229.302165142779;4424.181526417623;4461.549996251231;4461.709988850715;4518.299663552155;4519.977400112978;4525.094981003813;4529.660275479287;4540.387047748578;4487.685861989695;4663.764102512837;4697.976510117427;5308.708021058879;5338.065838478251;5613.772081053411;6260.46786023184;6310.810675679737;6502.44729198014;6599.954014255596;1349.5883755454483;1474.6239708874168;1539.5304432148303;1548.9457868974532;1550.7284027097671;954.5179684259405;1007.6624330849247;1019.2152042926905;1019.5004447820514;1029.4801125431609;5020.246962955586;5305.628605997543;6239.816064377523;6281.59169653971;6298.685065746694;5923.526117910556;6821.522493425413;6824.488163387766;6871;6875.518713690094;5983.730732117066;6208.596441231305;6227.159333489921;6246.562740608205;6254.186955695822;2929.1505463415797;3074.6156730408698;3326.4531992623547;3556.342076715764;3558.1994051338243;6701.128853249046;6828.419584335288;6862.313768623198;6903.068085808452;6943.89584156238;5487.98472282629;5743.396943320975;6759.290274521203;6944.409725173316;6965.407940325028;5690.5447564194765;6316.463100636497;6931.618760968095;6962.268961759044;6969.337912898267;5658.264425624642;6901.930980690129;6905.654717264017;6907.240203577502;6921.7231310747;6117.388261173847;6278.6860656966055;6799.218089919723;6825.829354266183;6833.369152876079;6120.969395152996;6759.493038022069;6978.895316570357;7013.544119632207;7032.5077244592385;4437.844675436344;4460.754658493814;4465.6427485801705;4477.8208871646075;4502.257127574045;5888.263967004124;6550.246721627074;6876.349676077805;6881.488256786337;7134.714611415485;6239.9408195296355;6602.052394543717;6617.371349721961;6638.767643132467;6639.4688424924925;5605.887882242251;6213.968930155501;6434.06706027614;6464.030395440722;6466.967665161644;6403.29563747978;6429.935700643121;6435.806925792233;6441.549091563733;6442.291347951628;5191.351081114861;6593.406593406425;6606.504512161703;6626.337366263335;6641;5009.448960614257;5676.205331253545;6349;6433.453156481564;6434.549581529248 03:05:09 INFO - PID 6942 | |5;yui.html;831.4927893984672;846.6401779243823;859.3597769661603;874.02982689215;882.0121463960363;12924.676883077927;14232.288385580718;15387.69224615507;16648.084355360465;17851.821481785177;17237.741433878502;17892.37376691816;18000.639987200248;18016.369427070054;18059.81940180601;969.4958621516807;996.486809293211;997.9700608981706;1002.2332915319786;1005.0401866217744;1024.6823484719723;1027.1577306608583;1027.8715160604925;1029.1406675426028;1031.865857438532;1080.4543705428787;1080.6595922284455;1081.0378762901025;1086.0442810326902;1089.6785448292733;1057.693268952003;1066.5733706517378;1073.3988966178965;1074.962376316833;1076.4725284610524;757.3373298363931;770.045144021415;770.8882212079274;787.9606019698992;803.449636998652;16824.495265142064;16842;16911.577210569834;16921.915390422968;16996.49010529686;16778.328866845313;17048.403305884236;17149.485515434557;17316.56708582283;17384.913075434542;11597.6520704379;12432.12975091744;13973.23147226902;14066.71866562663;14069.296535173302;3392.0332705178907;3534.575850897883;3536.2220311531423;3541.5218945442293;3543.6456354364614;90175;108128;117296.41351793271;117794;119258.40370798178;13206.075574709677;13307.201567905957;13521.932390338183;13555.457781688621;13569.1858488491;24972;25182.370440738763;25392.365190870005;25509.61735573931;25906.22281331563;8625;8745.868811967826;8793.692220772242;8884.73345799627;8900.8664870027;4793.544613261734;4872.585830204473;4873.561379475864;4876.171050921352;4887.657863949489;4272.4445822042935;4289.970407102273;4358.869233922924;4384.473863136444;4396.582324679151;785.7996210966166;863.3524856357732;883.3110174064241;898.2140626951417;902.6434558349415;653.1769969837943;664.8504086580481;665.4177594604721;672.3041651890368;688.8760023195873;11051.281666691639;11724.296542207494;11806.291622502677;11914.88085119155;11915.821262681067;552.204825051924;656.4584218020152;658.5719282466436;669.9598024118568;693.8959156126521;4801.255805350176;5362.51737343641;5405.945840561053;5451.400345961941;5510.834674959678;75154.24845751582;104674.47662761637;104812.42781358286;108264;109474.45262773635;94358.52820735853;94922.0507794927;95203.09593808223;96020.05672104521;97720.53419198717;67305.32694673089;78237;78408.21591784123;79908.40183196304;80307.59846200848;9272;9713.902860971582;10580.36517808934;10797.784044318912;10812.459377031275;29187.124386268446;41525.58474415217;41712;42562.29750809933;43115.13769724651;53559;54711.72644136754;55087.94032656485;55500.444995551145;55741.442585573626;13697.931510342783;13839.238841863391;13907.374168162254;13918;14039.298035098409;15238.161901095546;15517;15609.531714048597;17526.561835953693;18460.538486537946;14346.426142954582;16570.83429165741;16905.239264232892;17306;17514.94910305386;16593.83406165923;16664;17097.145142743062;17140.97154170704;17181.74227386615;16047;16677.249523771217;16725.414610488573;16774.412895548598;16977.981321120773;11173.385463799568;11781.469833857325;11988.580399685969;12104.092193085378;12365.134440589072;11561.690253139393;13037.674058148623;13152;13216.669583260495;13558 03:05:09 INFO - PID 6942 | __end_tp_report 03:05:09 INFO - PID 6942 | __start_cc_report 03:05:09 INFO - PID 6942 | _x_x_mozilla_cycle_collect,427 03:05:09 INFO - PID 6942 | __end_cc_report 03:05:09 INFO - PID 6942 | __startTimestamp1491905109652__endTimestamp 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | ------- Summary: start ------- 03:05:09 INFO - PID 6942 | Number of tests: 6 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | [#0] dojo.html Cycles:165 Average:6165.71 Median:6412.78 stddev:757.81 (11.8%) stddev-sans-first:718.05 03:05:09 INFO - PID 6942 | Values: 2991.3 3366.7 3519.3 3547.2 3572.2 6102.9 6153.1 6155.0 6192.0 6214.9 4826.9 6120.0 6123.9 6140.5 6251.0 5407.8 5444.6 5454.6 5512.9 5537.8 5398.7 5461.2 5514.2 5526.1 5541.7 5354.4 5397.8 5456.4 5468.2 5498.8 5444.6 5446.4 5468.0 5468.9 5525.1 5379.9 5400.5 5408.6 5426.2 5473.8 5987.2 6071.7 6121.4 6156.7 6157.0 6681.7 6734.7 6749.5 6755.8 6758.6 6816.5 6841.2 6849.5 6865.5 6866.5 6200.7 6258.8 6259.1 6278.4 6329.2 6956.0 6961.9 6996.9 7003.1 7016.1 6347.2 6434.1 6494.6 6589.9 6691.9 5578.0 6620.5 6669.6 6795.9 6910.0 6402.1 6537.5 6705.7 6709.9 6723.6 5556.8 6600.7 6602.2 6633.1 6702.9 5368.1 5368.3 5368.9 5380.0 5417.2 4720.2 4791.0 4816.6 4835.1 4846.2 5911.3 6209.5 6278.2 6367.7 6423.8 6845.3 6861.1 6868.6 6869.9 6884.5 5805.4 6300.1 6398.2 6412.8 6414.7 5789.9 5865.5 5883.0 5900.2 5903.8 6754.2 6834.8 6876.4 6889.2 6943.0 6762.8 6835.6 6844.9 6855.0 6867.1 6889.8 6947.4 6952.5 6964.5 6970.4 6426.8 6520.8 6614.9 6635.5 6695.4 5964.4 6490.0 6771.6 6817.7 6820.7 6415.5 6511.3 6603.7 6610.5 6634.9 6557.9 6568.2 6575.6 6584.4 6601.8 6237.4 6253.8 6306.9 6352.3 6366.2 6583.3 6625.9 6643.4 6643.6 6644.5 6431.5 6446.4 6458.8 6477.0 6484.1 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | [#1] ext.html Cycles:180 Average:45597.67 Median:34734.24 stddev:81206.15 (233.8%) stddev-sans-first:81363.79 03:05:09 INFO - PID 6942 | Values: 635.3 744.9 827.1 1270.8 1277.2 38260.6 38935.0 38952.4 38995.6 39060.6 38913.8 39247.8 39309.0 39396.8 39463.6 8014.6 8116.6 8520.7 8736.0 8782.9 8649.6 8691.0 8728.7 8756.0 8770.0 8719.4 8764.4 8774.0 8782.5 8790.5 7237.2 7275.9 8740.2 8760.5 8766.1 8556.2 8620.0 8623.6 8632.1 8637.3 30067.0 37687.6 37968.1 38018.0 38051.2 3549.5 3585.9 3586.0 3599.0 3610.4 30781.0 30873.7 30884.0 30939.5 30978.8 3138.2 3161.0 3169.7 3175.9 3198.8 166164.2 261448.1 276641.0 297977.7 299027.0 43176.8 49069.3 49427.5 49534.5 49538.3 50980.5 51453.5 51470.7 51571.5 51781.2 14388.6 14457.3 14497.7 14523.2 14529.1 11975.5 12056.7 12057.6 12059.9 12067.0 13513.1 13516.6 13576.0 13581.2 13623.9 5892.8 5900.7 5933.7 5937.2 5950.8 1035.7 1055.0 1056.9 1082.1 1086.5 23697.8 24660.8 24687.0 24902.0 24984.9 1127.4 1130.6 1161.5 1163.8 1169.5 11058.8 11114.3 12163.1 12747.6 12753.5 354312.0 355758.0 356496.0 356690.2 356795.0 47370.5 53926.9 55891.4 56050.0 56282.4 1510.4 1549.5 1585.5 1587.2 1602.2 24331.6 24469.8 24504.4 24557.4 24608.6 35960.1 35967.5 40086.8 40282.0 50894.5 296733.0 298238.0 298649.0 299741.0 300333.0 29985.2 30595.4 34282.5 35186.0 35300.3 43834.0 43853.6 44620.8 44779.0 45158.3 30131.0 30389.4 30411.5 31203.1 31226.2 25353.7 29949.1 30553.8 30845.8 30916.9 35861.3 36551.5 36709.4 36840.4 36858.0 24475.8 25841.7 29192.7 29532.9 31864.7 21863.3 22108.9 23928.9 24271.0 24441.5 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | [#2] jquery.html Cycles:180 Average:41299.07 Median:2310.68 stddev:117045.25 (5065.4%) stddev-sans-first:117333.39 03:05:09 INFO - PID 6942 | Values: 439.3 445.7 446.2 460.2 465.0 21529.2 22242.0 22657.8 23081.7 23144.2 20382.0 23153.4 23517.8 23826.0 24125.0 6138.6 6235.7 6247.5 6351.5 6398.3 6219.6 6282.8 6330.1 6336.0 6355.8 6016.2 6283.0 6321.7 6333.6 6337.1 5991.3 6241.7 6289.2 6339.1 6354.7 5621.2 5637.9 5643.4 5643.5 5656.1 27652.3 27666.2 28797.9 28814.4 28953.3 2242.2 2272.0 2306.0 2310.7 2310.7 14037.9 17342.0 17438.7 17624.6 18310.6 2104.8 2192.5 2214.1 2229.4 2229.7 165726.2 169264.0 169596.0 169992.0 171264.0 10321.5 11137.1 12408.3 12870.5 12908.7 16614.0 16756.8 16775.5 16786.7 16800.6 9029.9 9273.3 9303.0 9303.0 9416.9 8909.0 8915.6 8924.1 8948.5 9068.0 7915.7 8047.2 8075.4 8095.7 8103.5 2175.2 2177.9 2178.8 2180.3 2314.4 833.3 951.9 953.2 985.7 1022.6 20248.8 20780.5 20894.6 21144.0 21207.7 893.9 1006.3 1016.8 1032.5 1041.1 9851.2 10999.6 11057.6 11068.9 11094.7 684052.0 685655.0 687063.0 692274.0 724626.0 133537.0 146612.0 156668.4 161482.0 164054.0 1094.8 1183.8 1199.3 1217.6 1260.5 19254.8 20235.9 22702.7 22710.5 22752.8 62762.0 63022.4 63741.0 64427.7 64694.0 88044.0 88341.0 90295.0 90371.5 90786.5 8797.8 8879.5 8893.0 9012.9 9026.2 12015.9 12970.9 13668.0 13865.4 14272.8 10955.3 11845.1 11899.6 11980.5 12009.9 8888.4 11076.4 11116.7 11327.3 11496.5 11673.5 11754.4 12016.8 12057.3 12209.9 8756.3 8899.7 8907.4 8931.6 8951.0 10351.2 11031.6 11942.8 11983.1 12012.9 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | [#3] mootools.html Cycles:180 Average:7182.52 Median:2533.91 stddev:4532.82 (178.9%) stddev-sans-first:4523.08 03:05:09 INFO - PID 6942 | Values: 1178.8 1183.2 1424.4 1431.6 1476.4 9399.5 11404.9 11893.9 11942.0 12235.3 11822.5 11977.6 12026.2 12061.6 12089.8 2486.9 2519.9 2531.6 2536.2 2537.6 2437.0 2472.9 2517.8 2523.8 2531.2 2465.1 2487.7 2489.8 2514.2 2519.6 2423.6 2481.2 2483.4 2491.1 2500.7 2367.4 2481.1 2481.6 2494.8 2496.7 11916.3 11962.0 11987.9 11997.6 12014.2 6580.3 6821.0 6827.5 6843.2 6862.7 4058.4 4313.5 4314.9 4390.1 4419.3 1250.2 1253.9 1272.2 1285.9 1296.5 13413.5 16317.2 16408.7 16448.3 16614.9 4762.9 4768.5 4847.4 6163.7 6219.8 12763.9 13737.2 14036.4 14040.9 14057.6 6760.1 6775.7 6783.0 6828.1 6829.2 4986.3 5847.6 6140.4 6194.3 6202.1 4502.7 4657.7 4733.8 4771.9 4775.0 1448.9 1481.3 1481.7 1505.3 1523.0 784.7 796.1 818.1 824.3 848.1 6269.6 6700.2 6870.3 6928.0 6942.9 577.3 578.8 596.4 621.2 625.2 3487.3 4171.1 4370.3 4448.4 4453.6 14843.1 15167.3 15199.8 15216.9 15217.7 14431.5 14962.6 14991.8 15101.5 15116.1 9195.9 10583.5 10863.7 10873.5 10883.6 6294.8 6769.4 7119.0 7175.7 7181.4 10313.9 12338.8 12556.7 12763.6 12795.8 12834.3 12852.4 12861.2 12868.4 13019.0 9524.5 9735.1 9735.2 9737.2 9761.0 10647.7 10799.8 10868.7 10908.2 10913.7 9265.2 9276.3 9295.0 9415.2 9486.3 8170.6 8521.0 9137.0 9203.0 9305.7 8172.2 8183.4 8219.7 8280.5 8287.2 5128.5 5843.8 6035.1 6117.8 6275.2 4949.5 4953.6 5762.7 6125.9 6391.2 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | [#4] prototype.html Cycles:180 Average:5261.50 Median:5771.16 stddev:1656.87 (28.7%) stddev-sans-first:1619.23 03:05:09 INFO - PID 6942 | Values: 305.8 397.8 398.6 405.8 413.4 5299.7 5878.9 6168.3 6218.4 6263.7 5280.9 5920.5 6031.9 6078.5 6115.4 4019.0 4588.0 4594.0 4608.0 4609.3 4085.2 4612.9 4617.2 4627.2 4641.4 4301.4 4346.8 4526.4 4595.1 4640.7 4517.8 4537.1 4552.2 4566.7 4616.4 3522.8 4013.0 4053.3 4061.2 4073.6 5017.3 5229.4 5603.3 5952.9 5957.7 5119.5 5340.0 5347.1 5354.8 5363.5 5705.7 6574.6 6615.7 6617.9 6634.4 4174.7 4205.8 4348.2 4399.8 4399.9 5798.9 6636.4 6885.5 6952.6 6957.5 4081.8 4229.3 4424.2 4461.5 4461.7 4518.3 4520.0 4525.1 4529.7 4540.4 4487.7 4663.8 4698.0 5308.7 5338.1 5613.8 6260.5 6310.8 6502.4 6600.0 1349.6 1474.6 1539.5 1548.9 1550.7 954.5 1007.7 1019.2 1019.5 1029.5 5020.2 5305.6 6239.8 6281.6 6298.7 5923.5 6821.5 6824.5 6871.0 6875.5 5983.7 6208.6 6227.2 6246.6 6254.2 2929.2 3074.6 3326.5 3556.3 3558.2 6701.1 6828.4 6862.3 6903.1 6943.9 5488.0 5743.4 6759.3 6944.4 6965.4 5690.5 6316.5 6931.6 6962.3 6969.3 5658.3 6901.9 6905.7 6907.2 6921.7 6117.4 6278.7 6799.2 6825.8 6833.4 6121.0 6759.5 6978.9 7013.5 7032.5 4437.8 4460.8 4465.6 4477.8 4502.3 5888.3 6550.2 6876.3 6881.5 7134.7 6239.9 6602.1 6617.4 6638.8 6639.5 5605.9 6214.0 6434.1 6464.0 6467.0 6403.3 6429.9 6435.8 6441.5 6442.3 5191.4 6593.4 6606.5 6626.3 6641.0 5009.4 5676.2 6349.0 6433.5 6434.5 03:05:09 INFO - PID 6942 | 03:05:09 INFO - PID 6942 | [#5] yui.html Cycles:180 Average:21092.35 Median:17520.76 stddev:29155.03 (166.4%) stddev-sans-first:29197.12 03:05:09 INFO - PID 6942 | Values: 831.5 846.6 859.4 874.0 882.0 12924.7 14232.3 15387.7 16648.1 17851.8 17237.7 17892.4 18000.6 18016.4 18059.8 969.5 996.5 998.0 1002.2 1005.0 1024.7 1027.2 1027.9 1029.1 1031.9 1080.5 1080.7 1081.0 1086.0 1089.7 1057.7 1066.6 1073.4 1075.0 1076.5 757.3 770.0 770.9 788.0 803.4 16824.5 16842.0 16911.6 16921.9 16996.5 16778.3 17048.4 17149.5 17316.6 17384.9 11597.7 12432.1 13973.2 14066.7 14069.3 3392.0 3534.6 3536.2 3541.5 3543.6 90175.0 108128.0 117296.4 117794.0 119258.4 13206.1 13307.2 13521.9 13555.5 13569.2 24972.0 25182.4 25392.4 25509.6 25906.2 8625.0 8745.9 8793.7 8884.7 8900.9 4793.5 4872.6 4873.6 4876.2 4887.7 4272.4 4290.0 4358.9 4384.5 4396.6 785.8 863.4 883.3 898.2 902.6 653.2 664.9 665.4 672.3 688.9 11051.3 11724.3 11806.3 11914.9 11915.8 552.2 656.5 658.6 670.0 693.9 4801.3 5362.5 5405.9 5451.4 5510.8 75154.2 104674.5 104812.4 108264.0 109474.5 94358.5 94922.1 95203.1 96020.1 97720.5 67305.3 78237.0 78408.2 79908.4 80307.6 9272.0 9713.9 10580.4 10797.8 10812.5 29187.1 41525.6 41712.0 42562.3 43115.1 53559.0 54711.7 55087.9 55500.4 55741.4 13697.9 13839.2 13907.4 13918.0 14039.3 15238.2 15517.0 15609.5 17526.6 18460.5 14346.4 16570.8 16905.2 17306.0 17514.9 16593.8 16664.0 17097.1 17141.0 17181.7 16047.0 16677.2 16725.4 16774.4 16978.0 11173.4 11781.5 11988.6 12104.1 12365.1 11561.7 13037.7 13152.0 13216.7 13558.0 03:05:09 INFO - PID 6942 | -------- Summary: end -------- 03:05:09 INFO - PID 6942 | 03:05:10 INFO - TEST-INFO | 6942: exit 0 03:05:10 INFO - TEST-OK | dromaeo_css | took 1115390ms 03:05:10 INFO - TEST-START | kraken 03:05:10 INFO - operating with platform_type : mac_ 03:05:10 INFO - Initialising browser for kraken test... 03:05:10 INFO - TEST-INFO | started process 6946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmp8Ov8Y3/profile http://localhost:61909/getInfo.html) 03:05:13 INFO - PID 6946 | 2017-04-11 03:05:13.257 plugin-container[6947:135095] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 03:05:13 INFO - PID 6946 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:13 INFO - PID 6946 | 2017-04-11 03:05:13.260 plugin-container[6947:135095] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:05:13 INFO - PID 6946 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:13 INFO - PID 6946 | 2017-04-11 03:05:13.260 plugin-container[6947:135095] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:13 INFO - PID 6946 | __metrics Screen width/height:1600/1200 03:05:13 INFO - PID 6946 | colorDepth:24 03:05:13 INFO - PID 6946 | Browser inner width/height: 1024/689 03:05:13 INFO - PID 6946 | __metrics 03:05:13 ERROR - PID 6946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 03:05:14 INFO - TEST-INFO | 6946: exit 0 03:05:14 INFO - Browser initialized. 03:05:14 INFO - Running cycle 1/1 for kraken test... 03:05:14 INFO - TEST-INFO | started process 6948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmp8Ov8Y3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:16 INFO - PID 6948 | 2017-04-11 03:05:16.893 plugin-container[6949:135227] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 03:05:16 INFO - PID 6948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:16 INFO - PID 6948 | 2017-04-11 03:05:16.893 plugin-container[6949:135227] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:05:16 INFO - PID 6948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:16 INFO - PID 6948 | 2017-04-11 03:05:16.893 plugin-container[6949:135227] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:26 INFO - PID 6948 | RSS: Main: 235913216 03:05:26 INFO - PID 6948 | 03:05:29 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:30 INFO - PID 6948 | RSS: Main: 249819136 03:05:30 INFO - PID 6948 | 03:05:33 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-dft) 03:05:33 INFO - PID 6948 | RSS: Main: 258347008 03:05:33 INFO - PID 6948 | 03:05:37 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-fft) 03:05:37 INFO - PID 6948 | RSS: Main: 260763648 03:05:37 INFO - PID 6948 | 03:05:39 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-oscillator) 03:05:40 INFO - PID 6948 | RSS: Main: 261804032 03:05:40 INFO - PID 6948 | 03:05:42 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:43 INFO - PID 6948 | RSS: Main: 262115328 03:05:43 INFO - PID 6948 | 03:05:46 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61909/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:47 INFO - PID 6948 | RSS: Main: 267616256 03:05:47 INFO - PID 6948 | 03:05:50 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61909/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:51 INFO - PID 6948 | RSS: Main: 265588736 03:05:51 INFO - PID 6948 | 03:05:54 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61909/tests/kraken/driver.html?testName=json-parse-financial) 03:05:55 INFO - PID 6948 | RSS: Main: 266727424 03:05:55 INFO - PID 6948 | 03:05:56 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:57 INFO - PID 6948 | RSS: Main: 266702848 03:05:57 INFO - PID 6948 | 03:05:59 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:00 INFO - PID 6948 | RSS: Main: 266711040 03:06:00 INFO - PID 6948 | 03:06:02 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:03 INFO - PID 6948 | RSS: Main: 266829824 03:06:03 INFO - PID 6948 | 03:06:06 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:07 INFO - PID 6948 | RSS: Main: 267341824 03:06:07 INFO - PID 6948 | 03:06:10 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:10 INFO - PID 6948 | RSS: Main: 266485760 03:06:10 INFO - PID 6948 | 03:06:12 INFO - PID 6948 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61909/tests/kraken/driver.html?testName=ai-astar) 03:06:13 INFO - PID 6948 | RSS: Main: 269889536 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | __start_tp_report 03:06:13 INFO - PID 6948 | _x_x_mozilla_page_load 03:06:13 INFO - PID 6948 | _x_x_mozilla_page_load_details 03:06:13 INFO - PID 6948 | |i|pagename|runs| 03:06:13 INFO - PID 6948 | |0;ai-astar;108;122;121;165;123;125;122;123;140;130 03:06:13 INFO - PID 6948 | |1;audio-beat-detection;154;114;120;159;133;155;108;160;185;154 03:06:13 INFO - PID 6948 | |2;audio-dft;225;227;227;226;223;216;218;217;208;213 03:06:13 INFO - PID 6948 | |3;audio-fft;89;57;64;95;92;80;60;58;74;57 03:06:13 INFO - PID 6948 | |4;audio-oscillator;92;54;106;112;110;107;124;71;74;85 03:06:13 INFO - PID 6948 | |5;imaging-gaussian-blur;90;90;90;145;104;143;141;90;91;83 03:06:13 INFO - PID 6948 | |6;imaging-darkroom;116;159;98;101;123;163;132;161;115;101 03:06:13 INFO - PID 6948 | |7;imaging-desaturate;110;92;165;165;101;102;105;107;87;153 03:06:13 INFO - PID 6948 | |8;json-parse-financial;53;51;54;58;85;79;81;83;59;54 03:06:13 INFO - PID 6948 | |9;json-stringify-tinderbox;59;67;60;68;57;66;86;77;60;63 03:06:13 INFO - PID 6948 | |10;stanford-crypto-aes;76;97;114;116;110;89;90;105;83;90 03:06:13 INFO - PID 6948 | |11;stanford-crypto-ccm;147;183;157;132;166;173;153;172;208;143 03:06:13 INFO - PID 6948 | |12;stanford-crypto-pbkdf2;197;197;200;198;205;231;197;194;195;197 03:06:13 INFO - PID 6948 | |13;stanford-crypto-sha256-iterative;72;96;67;73;73;72;71;74;95;71 03:06:13 INFO - PID 6948 | __end_tp_report 03:06:13 INFO - PID 6948 | __start_cc_report 03:06:13 INFO - PID 6948 | _x_x_mozilla_cycle_collect,988 03:06:13 INFO - PID 6948 | __end_cc_report 03:06:13 INFO - PID 6948 | __startTimestamp1491905173064__endTimestamp 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | ------- Summary: start ------- 03:06:13 INFO - PID 6948 | Number of tests: 14 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#0] ai-astar Cycles:10 Average:127.90 Median:124.00 stddev:15.26 (12.3%) stddev-sans-first:14.39 03:06:13 INFO - PID 6948 | Values: 108.0 122.0 121.0 165.0 123.0 125.0 122.0 123.0 140.0 130.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:154.50 stddev:24.44 (15.8%) stddev-sans-first:25.66 03:06:13 INFO - PID 6948 | Values: 154.0 114.0 120.0 159.0 133.0 155.0 108.0 160.0 185.0 154.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#2] audio-dft Cycles:10 Average:220.00 Median:224.00 stddev:6.58 (2.9%) stddev-sans-first:6.73 03:06:13 INFO - PID 6948 | Values: 225.0 227.0 227.0 226.0 223.0 216.0 218.0 217.0 208.0 213.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#3] audio-fft Cycles:10 Average:72.60 Median:77.00 stddev:15.41 (20.0%) stddev-sans-first:15.16 03:06:13 INFO - PID 6948 | Values: 89.0 57.0 64.0 95.0 92.0 80.0 60.0 58.0 74.0 57.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:62.50 stddev:22.12 (35.4%) stddev-sans-first:23.46 03:06:13 INFO - PID 6948 | Values: 92.0 54.0 106.0 112.0 110.0 107.0 124.0 71.0 74.0 85.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#5] imaging-gaussian-blur Cycles:10 Average:106.70 Median:90.00 stddev:25.59 (28.4%) stddev-sans-first:26.42 03:06:13 INFO - PID 6948 | Values: 90.0 90.0 90.0 145.0 104.0 143.0 141.0 90.0 91.0 83.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#6] imaging-darkroom Cycles:10 Average:126.90 Median:145.50 stddev:25.77 (17.7%) stddev-sans-first:27.03 03:06:13 INFO - PID 6948 | Values: 116.0 159.0 98.0 101.0 123.0 163.0 132.0 161.0 115.0 101.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#7] imaging-desaturate Cycles:10 Average:118.70 Median:159.00 stddev:30.14 (19.0%) stddev-sans-first:31.80 03:06:13 INFO - PID 6948 | Values: 110.0 92.0 165.0 165.0 101.0 102.0 105.0 107.0 87.0 153.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:69.00 stddev:14.29 (20.7%) stddev-sans-first:14.40 03:06:13 INFO - PID 6948 | Values: 53.0 51.0 54.0 58.0 85.0 79.0 81.0 83.0 59.0 54.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:9.04 (13.6%) stddev-sans-first:9.20 03:06:13 INFO - PID 6948 | Values: 59.0 67.0 60.0 68.0 57.0 66.0 86.0 77.0 60.0 63.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#10] stanford-crypto-aes Cycles:10 Average:97.00 Median:86.00 stddev:13.67 (15.9%) stddev-sans-first:12.21 03:06:13 INFO - PID 6948 | Values: 76.0 97.0 114.0 116.0 110.0 89.0 90.0 105.0 83.0 90.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#11] stanford-crypto-ccm Cycles:10 Average:163.40 Median:169.00 stddev:22.03 (13.0%) stddev-sans-first:22.55 03:06:13 INFO - PID 6948 | Values: 147.0 183.0 157.0 132.0 166.0 173.0 153.0 172.0 208.0 143.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.10 Median:197.50 stddev:10.93 (5.5%) stddev-sans-first:11.49 03:06:13 INFO - PID 6948 | Values: 197.0 197.0 200.0 198.0 205.0 231.0 197.0 194.0 195.0 197.0 03:06:13 INFO - PID 6948 | 03:06:13 INFO - PID 6948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:73.00 stddev:10.24 (14.0%) stddev-sans-first:10.74 03:06:13 INFO - PID 6948 | Values: 72.0 96.0 67.0 73.0 73.0 72.0 71.0 74.0 95.0 71.0 03:06:13 INFO - PID 6948 | -------- Summary: end -------- 03:06:13 INFO - PID 6948 | 03:06:14 INFO - TEST-INFO | 6948: exit 0 03:06:14 INFO - TEST-OK | kraken | took 63868ms 03:06:14 INFO - SUITE-END | took 1179s 03:06:14 INFO - Completed test suite (00:19:39) 03:06:14 INFO - javascript benchmark 03:06:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7921.649593760966, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.282092297849, 3366.713829324509, 3519.2961407718453, 3547.2018795770937, 3572.2498275362173, 6102.943731970943, 6153.138560601514, 6154.969225153879, 6192.0, 6214.906776398347, 4826.913944362516, 6119.9595720210555, 6123.892747182678, 6140.508759299268, 6251.0, 5407.756650950697, 5444.591655625824, 5454.59090568207, 5512.862178445551, 5537.750801213935, 5398.676079435227, 5461.15352120422, 5514.172874068881, 5526.115821468566, 5541.695206763647, 5354.41101478837, 5397.838064858021, 5456.372517160498, 5468.234447177399, 5498.752556134984, 5444.564434845203, 5446.428125046892, 5468.043092458804, 5468.890622187574, 5525.060739674265, 5379.919301210485, 5400.540954018913, 5408.621396502246, 5426.213199086111, 5473.808416705436, 5987.161797348374, 6071.696415179224, 6121.361519882465, 6156.6921653917125, 6156.96921515394, 6681.665916704145, 6734.663266836638, 6749.527533072687, 6755.763548275787, 6758.560693554952, 6816.454683625348, 6841.2132604750595, 6849.452043836481, 6865.450763938873, 6866.519343645947, 6200.689965501752, 6258.812235632939, 6259.061140828912, 6278.372162783685, 6329.177206963065, 6956.0, 6961.93038069623, 6996.8950465743055, 7003.124609423822, 7016.087908571853, 6347.174867267226, 6434.0670602763275, 6494.577852439671, 6589.9341006590275, 6691.899621505681, 5578.0, 6620.5365624406795, 6669.599824010478, 6795.864082718318, 6909.965450172717, 6402.103705481236, 6537.477001839841, 6705.664716764142, 6709.932900671029, 6723.596584204865, 5556.82597758979, 6600.73597056122, 6602.1747281589805, 6633.1376920999965, 6702.932970670328, 5368.087425137736, 5368.2752828367675, 5368.91946620801, 5380.0, 5417.18742188667, 4720.173969555314, 4791.0178413425165, 4816.638752093607, 4835.057163853015, 4846.224604063404, 5911.349751527328, 6209.534284928648, 6278.246610406781, 6367.745290188341, 6423.775167869196, 6845.315468453115, 6861.1080559526945, 6868.62222577753, 6869.896951545731, 6884.48366372514, 5805.419458054245, 6300.117983482224, 6398.168238129014, 6412.775552855627, 6414.711337989708, 5789.8552536186935, 5865.472107510344, 5883.0, 5900.1739756434135, 5903.793367232212, 6754.155730533684, 6834.760783372658, 6876.381125698511, 6889.242183359726, 6942.965285173542, 6762.830929226612, 6835.624040677811, 6844.8973265402055, 6855.006024126374, 6867.107276054081, 6889.793306200822, 6947.374736273558, 6952.5480843745, 6964.477664175106, 6970.372666460043, 6426.839329016812, 6520.836979075561, 6614.900776488453, 6635.535512514078, 6695.4308883745425, 5964.403559644001, 6490.0, 6771.593704377753, 6817.659117044227, 6820.658967051727, 6415.454686351713, 6511.2512061113575, 6603.688708951829, 6610.4711623071, 6634.867302654016, 6557.868842623026, 6568.244651865097, 6575.5725877819705, 6584.374484423972, 6601.768938087336, 6237.407446292595, 6253.843653908689, 6306.936930630818, 6352.301246862934, 6366.236051673829, 6583.341665833378, 6625.900611490735, 6643.435307998874, 6643.56816806906, 6644.468442524683, 6431.549791514549, 6446.387593178828, 6458.806235812933, 6476.996065609838, 6484.1246431731115], "value": 6112.841073349362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.3043417457883, 744.8752383900312, 827.0902007791428, 1270.7649084919285, 1277.1953669188404, 38260.617393826054, 38935.0, 38952.41571376432, 38995.61004389955, 39060.60939390605, 38913.805430972876, 39247.80376098116, 39309.0, 39396.80301598495, 39463.60536394642, 8014.5992700364895, 8116.6347514362, 8520.744377668649, 8735.956320218422, 8782.868256976119, 8649.567521623925, 8690.95708514979, 8728.734333521636, 8755.95622021889, 8769.95615021924, 8719.389642725011, 8764.43031202973, 8774.0, 8782.516961567111, 8790.47257164569, 7237.240089790549, 7275.927240727631, 8740.213380795727, 8760.474371537728, 8766.123387661246, 8556.229939305493, 8619.956900215459, 8623.568821558896, 8632.13678632138, 8637.309015278826, 30067.0, 37687.62312376869, 37968.05079872998, 38018.0, 38051.238975220615, 3549.538559987211, 3585.8924232273075, 3585.982070089659, 3599.046252743025, 3610.4042832932537, 30781.0, 30873.691263087305, 30884.0, 30939.535906961413, 30978.84510577455, 3138.246820763023, 3160.984195079033, 3169.683031696835, 3175.872965081394, 3198.824064676442, 166164.16917915453, 261448.07827882597, 276641.0, 297977.6516761252, 299027.0, 43176.784116079216, 49069.26396104061, 49427.50572494229, 49534.50465495371, 49538.25692614542, 50980.490195097576, 51453.48546514487, 51470.713232169495, 51571.45285641362, 51781.223281650804, 14388.640283992774, 14457.277136143151, 14497.710045799025, 14523.201223932574, 14529.128252304896, 11975.46110425033, 12056.698582535506, 12057.57798477049, 12059.939700301618, 12067.0, 13513.121647093105, 13516.594502164951, 13576.049676522549, 13581.185128892299, 13623.863761362458, 5892.823215303548, 5900.675462849498, 5933.673647949404, 5937.198478205473, 5950.821475355746, 1035.6530562261726, 1054.984175237372, 1056.8626078609732, 1082.1234799812178, 1086.4567716141928, 23697.7630223699, 24660.753392465846, 24687.02503799692, 24902.0, 24984.875680594418, 1127.3912087472836, 1130.649498655403, 1161.454116565213, 1163.8196079607674, 1169.4912712969715, 11058.834117488244, 11114.277571957797, 12163.14857959952, 12747.61757147287, 12753.48986040548, 354312.0, 355758.0, 356496.0, 356690.2165489156, 356795.0, 47370.52629473661, 53926.921461571335, 55891.44108558944, 56050.0, 56282.43717562854, 1510.358097808449, 1549.511903750315, 1585.47679265842, 1587.1508742822534, 1602.198900549725, 24331.63502547428, 24469.75530244675, 24504.387390315384, 24557.38606534851, 24608.630870537316, 35960.100997475274, 35967.460488092176, 40086.79739607817, 40282.0, 50894.491055088976, 296733.0, 298238.0, 298649.0, 299741.0, 300333.0, 29985.151410615956, 30595.388092237587, 34282.48576271408, 35186.0, 35300.29399412049, 43834.0, 43853.56146438622, 44620.77689611531, 44779.0, 45158.32262516131, 30131.0, 30389.392212156075, 30411.54382684217, 31203.063908082793, 31226.21934451657, 25353.746462535877, 29949.101526954226, 30553.847230763702, 30845.8457707719, 30916.917907873118, 35861.28277434489, 36551.45172822463, 36709.44935826018, 36840.44739328966, 36858.0, 24475.75524244806, 25841.70791460457, 29192.686329114815, 29532.852335738186, 31864.681353187098, 21863.344099677037, 22108.88945555262, 23928.88035559811, 24271.0, 24441.51116977686], "value": 17662.02256784128, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.25984715753975, 445.7325604637217, 446.1567637165757, 460.2199272233563, 465.00952970173523, 21529.24647637333, 22241.955599900226, 22657.773422265793, 23081.653775193387, 23144.178644253236, 20382.0, 23153.421164470896, 23517.76482235177, 23826.0, 24125.03499860008, 6138.570300078996, 6235.719392627343, 6247.531435142359, 6351.49188064956, 6398.328175541571, 6219.564630475868, 6282.780102696406, 6330.145430366911, 6336.049592561107, 6355.809325720235, 6016.217891674076, 6282.9685851570675, 6321.715522801485, 6333.55665103443, 6337.081123237128, 5991.2510936132985, 6241.687915604201, 6289.1509646197865, 6339.080833279195, 6354.68226588671, 5621.241132447109, 5637.943620563824, 5643.351014633328, 5643.492085712305, 5656.123300888327, 27652.30869228265, 27666.170014899584, 28797.85601072002, 28814.423711525862, 28953.276168095756, 2242.159190303636, 2272.0457407888725, 2306.0199415248453, 2310.653401989698, 2310.7111611048617, 14037.929810350985, 17342.0, 17438.651226975515, 17624.559386015324, 18310.633787324314, 2104.7684754676975, 2192.506685995654, 2214.147553192033, 2229.3646310801505, 2229.721284839395, 165726.1713691436, 169264.0, 169596.0, 169991.99999999878, 171264.0, 10321.535530901128, 11137.05335046514, 12408.317542535247, 12870.485180592672, 12908.677283067811, 16614.0, 16756.83243167577, 16775.496735097968, 16786.66426671484, 16800.579985500215, 9029.909700903037, 9273.258139348836, 9302.953485232665, 9302.976672566012, 9416.90583094174, 8909.0, 8915.55422228886, 8924.107589241154, 8948.463092214488, 9068.0, 7915.683372665144, 8047.235512626291, 8075.434719569574, 8095.676172953016, 8103.513789172668, 2175.19517778423, 2177.911044477761, 2178.7603363629987, 2180.269609680743, 2314.3635500237233, 833.258400023967, 951.8857737071596, 953.1707414549248, 985.7387792235063, 1022.5602990714065, 20248.797512024692, 20780.480487987923, 20894.582108358052, 21144.0, 21207.68188477174, 893.8748575199477, 1006.2955930848435, 1016.7900198763448, 1032.5198782566142, 1041.0994489766297, 9851.211903047739, 10999.61501347449, 11057.557697692002, 11068.944655276671, 11094.722631934104, 684052.0, 685655.0, 687063.0, 692274.0, 724626.0, 133537.0, 146612.0, 156668.43331566767, 161482.0, 164054.0, 1094.7974624694457, 1183.7810005149074, 1199.2684462477882, 1217.6468824040928, 1260.4706023470164, 19254.807451925302, 20235.898820505805, 22702.65946010778, 22710.545789084455, 22752.772472275727, 62762.0, 63022.36977630165, 63741.0, 64427.67786161227, 64694.0, 88044.0, 88341.0, 90295.0, 90371.54814225886, 90786.54606726924, 8797.780055498664, 8879.511626860585, 8893.0, 9012.909870901207, 9026.18764311215, 12015.939920300343, 12970.870291297344, 13668.043236973317, 13865.4453821846, 14272.785908211177, 10955.34267943926, 11845.11161662896, 11899.631542372392, 11980.520779168735, 12009.939950300193, 8888.422252553562, 11076.446177690923, 11116.722081948015, 11327.32036077838, 11496.540138394705, 11673.474693638977, 11754.353510557, 12016.75966480683, 12057.336846473529, 12209.877901221229, 8756.299496040428, 8899.73300800977, 8907.376483646083, 8931.642734290815, 8951.0, 10351.223658225512, 11031.613893513688, 11942.820857686967, 11983.101267405154, 12012.879871201176], "value": 10780.941312932895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1178.7819253438113, 1183.1599564309345, 1424.430227908837, 1431.584840396285, 1476.4094362255096, 9399.483028433433, 11404.885951140486, 11893.940530297346, 11941.98493128084, 12235.265884046963, 11822.527098916054, 11977.640670779869, 12026.218295810788, 12061.577844775435, 12089.758204835898, 2486.875656217191, 2519.8866051027658, 2531.5822889223255, 2536.2391282615235, 2537.581299085649, 2436.9512609747794, 2472.888720007595, 2517.7985761139157, 2523.823332366735, 2531.2153232497985, 2465.103503383526, 2487.6890388701413, 2489.8132640051977, 2514.245726282117, 2519.6472493850874, 2423.6364545318256, 2481.2060140754966, 2483.4412257242066, 2491.1281051631963, 2500.6999160100722, 2367.4318163640773, 2481.0695989004125, 2481.6029435290448, 2494.8128890333296, 2496.7378425265447, 11916.285022898654, 11962.0, 11987.861153190433, 11997.580084697081, 12014.159008869383, 6580.309067547886, 6821.0, 6827.48793840464, 6843.178818541757, 6862.730394876914, 4058.391241313797, 4313.547077556843, 4314.935275970863, 4390.056137930328, 4419.292913133883, 1250.1748845761754, 1253.931033793141, 1272.1540175783093, 1285.9292738899358, 1296.5008471738354, 13413.46346146153, 16317.184140792913, 16408.6718265634, 16448.259828307753, 16614.92003019812, 4762.904741905142, 4768.523147685204, 4847.394075740533, 6163.691815409212, 6219.787141507453, 12763.872361276268, 13737.175769453865, 14036.438542458187, 14040.929795350958, 14057.648558786112, 6760.121184246016, 6775.661216939134, 6782.966085169642, 6828.112345395067, 6829.214640316427, 4986.301917731448, 5847.619904706181, 6140.4473597376455, 6194.34959329273, 6202.100695399142, 4502.662300327489, 4657.69724967876, 4733.763311834395, 4771.904561908743, 4775.0, 1448.9058211216238, 1481.2965090146201, 1481.6814384907082, 1505.2925125191143, 1523.0404844947834, 784.7253461288503, 796.1322158846884, 818.1205204405288, 824.3446460064263, 848.1264297773304, 6269.632923264688, 6700.195976482853, 6870.27862074485, 6927.965360173167, 6942.93057069433, 577.2524580668045, 578.7916350113956, 596.4453058655405, 621.1862460177182, 625.1997443272618, 3487.2502411981545, 4171.124063946544, 4370.2570563004365, 4448.354988526646, 4453.576910193591, 14843.109413435228, 15167.317470713844, 15199.848001519844, 15216.923915380574, 15217.695646087017, 14431.49489767853, 14962.625934351729, 14991.775123373158, 15101.546953591409, 15116.09303441797, 9195.908040919505, 10583.5237414315, 10863.67408977732, 10873.456327183609, 10883.564657413774, 6294.8111556653375, 6769.424598909148, 7119.0, 7175.677094530654, 7181.353678168781, 10313.896861031593, 12338.75322493563, 12556.748865022832, 12763.553275635679, 12795.808062878878, 12834.29411382383, 12852.357382131044, 12861.228326300452, 12868.420921058387, 13019.0, 9524.476153811329, 9735.123838854537, 9735.1725103367, 9737.17234035115, 9761.0, 10647.680569582924, 10799.838002429813, 10868.67393978182, 10908.181886358396, 10913.727156821144, 9265.166135047879, 9276.304277179104, 9294.953525232331, 9415.15263626277, 9486.288528360263, 8170.591470426574, 8520.977482702116, 9136.95431522838, 9203.0, 9305.720828375159, 8172.223638754309, 8183.3862460316905, 8219.671213151407, 8280.461769984931, 8287.212714792086, 5128.538431541179, 5843.7954671587995, 6035.1249068885645, 6117.816465506042, 6275.152854364603, 4949.505049495022, 4953.554180123806, 5762.732198916232, 6125.877482450415, 6391.2330520336], "value": 5386.322150818542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.83637753801713, 397.8150160175519, 398.5735263268304, 405.76668415660964, 413.41501774988393, 5299.708516031616, 5878.853028674274, 6168.290646575645, 6218.440340369366, 6263.749450021999, 5280.867978300545, 5920.496757775594, 6031.909521357183, 6078.5441091918065, 6115.41903519166, 4018.97990510047, 4587.977060114695, 4594.0, 4608.0, 4609.285560738091, 4085.1829634073156, 4612.907741845161, 4617.191991401508, 4627.190241707688, 4641.350210970467, 4301.376300436435, 4346.76092814895, 4526.434195725535, 4595.126925884088, 4640.67515273931, 4517.837513740395, 4537.052764095259, 4552.203364411214, 4566.680332376735, 4616.39986801717, 3522.7710198836994, 4012.959870401288, 4053.3312003519386, 4061.187762447493, 4073.5926407359325, 5017.297578339036, 5229.398619158807, 5603.299587551556, 5952.9107063394085, 5957.702114894281, 5119.488051194888, 5339.973300133474, 5347.075052980924, 5354.759035843396, 5363.463653634644, 5705.657660540381, 6574.638394888279, 6615.669216539154, 6617.900731489031, 6634.402903738638, 4174.749515029078, 4205.810738516774, 4348.21732088224, 4399.780010999437, 4399.934000989988, 5798.927198468297, 6636.402723754837, 6885.518013739041, 6952.558483550675, 6957.5129740918155, 4081.77550234734, 4229.302165142779, 4424.181526417623, 4461.549996251231, 4461.709988850715, 4518.299663552155, 4519.977400112978, 4525.094981003813, 4529.660275479287, 4540.387047748578, 4487.685861989695, 4663.764102512837, 4697.976510117427, 5308.708021058879, 5338.065838478251, 5613.772081053411, 6260.46786023184, 6310.810675679737, 6502.44729198014, 6599.954014255596, 1349.5883755454483, 1474.6239708874168, 1539.5304432148303, 1548.9457868974532, 1550.7284027097671, 954.5179684259405, 1007.6624330849247, 1019.2152042926905, 1019.5004447820514, 1029.4801125431609, 5020.246962955586, 5305.628605997543, 6239.816064377523, 6281.59169653971, 6298.685065746694, 5923.526117910556, 6821.522493425413, 6824.488163387766, 6871.0, 6875.518713690094, 5983.730732117066, 6208.596441231305, 6227.159333489921, 6246.562740608205, 6254.186955695822, 2929.1505463415797, 3074.6156730408698, 3326.4531992623547, 3556.342076715764, 3558.1994051338243, 6701.128853249046, 6828.419584335288, 6862.313768623198, 6903.068085808452, 6943.89584156238, 5487.98472282629, 5743.396943320975, 6759.290274521203, 6944.409725173316, 6965.407940325028, 5690.5447564194765, 6316.463100636497, 6931.618760968095, 6962.268961759044, 6969.337912898267, 5658.264425624642, 6901.930980690129, 6905.654717264017, 6907.240203577502, 6921.7231310747, 6117.388261173847, 6278.6860656966055, 6799.218089919723, 6825.829354266183, 6833.369152876079, 6120.969395152996, 6759.493038022069, 6978.895316570357, 7013.544119632207, 7032.5077244592385, 4437.844675436344, 4460.754658493814, 4465.6427485801705, 4477.8208871646075, 4502.257127574045, 5888.263967004124, 6550.246721627074, 6876.349676077805, 6881.488256786337, 7134.714611415485, 6239.9408195296355, 6602.052394543717, 6617.371349721961, 6638.767643132467, 6639.4688424924925, 5605.887882242251, 6213.968930155501, 6434.06706027614, 6464.030395440722, 6466.967665161644, 6403.29563747978, 6429.935700643121, 6435.806925792233, 6441.549091563733, 6442.291347951628, 5191.351081114861, 6593.406593406425, 6606.504512161703, 6626.337366263335, 6641.0, 5009.448960614257, 5676.205331253545, 6349.0, 6433.453156481564, 6434.549581529248], "value": 4741.610572772407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.4927893984672, 846.6401779243823, 859.3597769661603, 874.02982689215, 882.0121463960363, 12924.676883077927, 14232.288385580718, 15387.69224615507, 16648.084355360465, 17851.821481785177, 17237.741433878502, 17892.37376691816, 18000.639987200248, 18016.369427070054, 18059.81940180601, 969.4958621516807, 996.486809293211, 997.9700608981706, 1002.2332915319786, 1005.0401866217744, 1024.6823484719723, 1027.1577306608583, 1027.8715160604925, 1029.1406675426028, 1031.865857438532, 1080.4543705428787, 1080.6595922284455, 1081.0378762901025, 1086.0442810326902, 1089.6785448292733, 1057.693268952003, 1066.5733706517378, 1073.3988966178965, 1074.962376316833, 1076.4725284610524, 757.3373298363931, 770.045144021415, 770.8882212079274, 787.9606019698992, 803.449636998652, 16824.495265142064, 16842.0, 16911.577210569834, 16921.915390422968, 16996.49010529686, 16778.328866845313, 17048.403305884236, 17149.485515434557, 17316.56708582283, 17384.913075434542, 11597.6520704379, 12432.12975091744, 13973.23147226902, 14066.71866562663, 14069.296535173302, 3392.0332705178907, 3534.575850897883, 3536.2220311531423, 3541.5218945442293, 3543.6456354364614, 90175.0, 108128.0, 117296.41351793271, 117794.0, 119258.40370798178, 13206.075574709677, 13307.201567905957, 13521.932390338183, 13555.457781688621, 13569.1858488491, 24972.0, 25182.370440738763, 25392.365190870005, 25509.61735573931, 25906.22281331563, 8625.0, 8745.868811967826, 8793.692220772242, 8884.73345799627, 8900.8664870027, 4793.544613261734, 4872.585830204473, 4873.561379475864, 4876.171050921352, 4887.657863949489, 4272.4445822042935, 4289.970407102273, 4358.869233922924, 4384.473863136444, 4396.582324679151, 785.7996210966166, 863.3524856357732, 883.3110174064241, 898.2140626951417, 902.6434558349415, 653.1769969837943, 664.8504086580481, 665.4177594604721, 672.3041651890368, 688.8760023195873, 11051.281666691639, 11724.296542207494, 11806.291622502677, 11914.88085119155, 11915.821262681067, 552.204825051924, 656.4584218020152, 658.5719282466436, 669.9598024118568, 693.8959156126521, 4801.255805350176, 5362.51737343641, 5405.945840561053, 5451.400345961941, 5510.834674959678, 75154.24845751582, 104674.47662761637, 104812.42781358286, 108264.0, 109474.45262773635, 94358.52820735853, 94922.0507794927, 95203.09593808223, 96020.05672104521, 97720.53419198717, 67305.32694673089, 78237.0, 78408.21591784123, 79908.40183196304, 80307.59846200848, 9272.0, 9713.902860971582, 10580.36517808934, 10797.784044318912, 10812.459377031275, 29187.124386268446, 41525.58474415217, 41712.0, 42562.29750809933, 43115.13769724651, 53559.0, 54711.72644136754, 55087.94032656485, 55500.444995551145, 55741.442585573626, 13697.931510342783, 13839.238841863391, 13907.374168162254, 13918.0, 14039.298035098409, 15238.161901095546, 15517.0, 15609.531714048597, 17526.561835953693, 18460.538486537946, 14346.426142954582, 16570.83429165741, 16905.239264232892, 17306.0, 17514.94910305386, 16593.83406165923, 16664.0, 17097.145142743062, 17140.97154170704, 17181.74227386615, 16047.0, 16677.249523771217, 16725.414610488573, 16774.412895548598, 16977.981321120773, 11173.385463799568, 11781.469833857325, 11988.580399685969, 12104.092193085378, 12365.134440589072, 11561.690253139393, 13037.674058148623, 13152.0, 13216.669583260495, 13558.0], "value": 8311.968696489374, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1680.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 122.0, 121.0, 165.0, 123.0, 125.0, 122.0, 123.0, 140.0, 130.0], "value": 127.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 114.0, 120.0, 159.0, 133.0, 155.0, 108.0, 160.0, 185.0, 154.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 227.0, 227.0, 226.0, 223.0, 216.0, 218.0, 217.0, 208.0, 213.0], "value": 220.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 57.0, 64.0, 95.0, 92.0, 80.0, 60.0, 58.0, 74.0, 57.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 54.0, 106.0, 112.0, 110.0, 107.0, 124.0, 71.0, 74.0, 85.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 145.0, 104.0, 143.0, 141.0, 90.0, 91.0, 83.0], "value": 106.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 159.0, 98.0, 101.0, 123.0, 163.0, 132.0, 161.0, 115.0, 101.0], "value": 126.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 92.0, 165.0, 165.0, 101.0, 102.0, 105.0, 107.0, 87.0, 153.0], "value": 118.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 54.0, 58.0, 85.0, 79.0, 81.0, 83.0, 59.0, 54.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 60.0, 68.0, 57.0, 66.0, 86.0, 77.0, 60.0, 63.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 97.0, 114.0, 116.0, 110.0, 89.0, 90.0, 105.0, 83.0, 90.0], "value": 97.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 183.0, 157.0, 132.0, 166.0, 173.0, 153.0, 172.0, 208.0, 143.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 200.0, 198.0, 205.0, 231.0, 197.0, 194.0, 195.0, 197.0], "value": 201.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 96.0, 67.0, 73.0, 73.0, 72.0, 71.0, 74.0, 95.0, 71.0], "value": 76.4, "unit": "score"}]}]} 03:06:14 INFO - Return code: 0 03:06:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:14 ERROR - # TBPL SUCCESS # 03:06:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:14 INFO - 2017-04-11 03:06:14.399 screenresolution[6953:135616] starting screenresolution argv=screenresolution get 03:06:14 INFO - 2017-04-11 03:06:14.402 screenresolution[6953:135616] Display 0: 1600x1200x32@60 03:06:14 INFO - 2017-04-11 03:06:14.408 screenresolution[6954:135619] starting screenresolution argv=screenresolution list 03:06:14 INFO - Available Modes on Display 0 03:06:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:14 INFO - Intel Iris: 03:06:14 INFO - Chipset Model: Intel Iris 03:06:14 INFO - Type: GPU 03:06:14 INFO - Bus: Built-In 03:06:14 INFO - VRAM (Dynamic, Max): 1536 MB 03:06:14 INFO - Vendor: Intel (0x8086) 03:06:14 INFO - Device ID: 0x0a2e 03:06:14 INFO - Revision ID: 0x0009 03:06:14 INFO - Displays: 03:06:14 INFO - Display: 03:06:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:14 INFO - Display Serial Number: 1600x1200 60 03:06:14 INFO - Main Display: Yes 03:06:14 INFO - Mirror: Off 03:06:14 INFO - Online: Yes 03:06:14 INFO - Rotation: Supported 03:06:14 INFO - Return code: 0 03:06:14 INFO - Running post-action listener: _resource_record_post_action 03:06:14 INFO - [mozharness: 2017-04-11 10:06:14.661680Z] Finished run-tests step (success) 03:06:14 INFO - Running post-run listener: _resource_record_post_run 03:06:14 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 532992; Write bytes: 518497280; Read time: 5; Write time: 1676 03:06:14 INFO - TinderboxPrint: CPU usage
54.1% 03:06:14 INFO - TinderboxPrint: I/O read bytes / time
532,992 / 5 03:06:14 INFO - TinderboxPrint: I/O write bytes / time
518,497,280 / 1,676 03:06:14 INFO - TinderboxPrint: CPU idle
2,203.1 (45.9%) 03:06:14 INFO - TinderboxPrint: CPU system
968.4 (20.2%) 03:06:14 INFO - TinderboxPrint: CPU user
1,626.3 (33.9%) 03:06:14 INFO - TinderboxPrint: Swap in / out
207,757,312 / 0 03:06:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196160000; Write bytes: 194344960; Read time: 14937; Write time: 438 03:06:14 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 532480; Write bytes: 307305472; Read time: 4; Write time: 1187 03:06:15 INFO - Running post-run listener: _upload_blobber_files 03:06:15 INFO - Blob upload gear active. 03:06:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:06:15 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:16 INFO - (blobuploader) - INFO - Done attempting. 03:06:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:17 INFO - (blobuploader) - INFO - Done attempting. 03:06:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:18 INFO - (blobuploader) - INFO - Done attempting. 03:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:20 INFO - (blobuploader) - INFO - Done attempting. 03:06:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:20 INFO - Return code: 0 03:06:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de37ab1fa38ac83e1677f67b4097192b943b002739b280f77f53f6f74702a55ba2ef7835acbd280088f3d0ef0b14302ee5a748deabdd1c9156fc34b19c9a0e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0e3006e00fe08c0ff132ceae76c7f725f8638ca450f365672f4041c9d8617bbc5bd173285de771d49ef72cf3639b2d99b82ea91f80c155a2357b018480fdd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b3c34b418e7e4146ab03e71c85d94d24e54d0849056953acc33a56deb40b29d9afcfcb68e4376b461369d7add0139995ccd19eaf7351c7f4b47c6904380da1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20cfc2d2089f495dcab758982894ddb6f5ddc8b08d40633c47352d7530a57ba0339b8f2d89377654c5a43507d17325c7ff753a0227ac514f45df2702ad72c8d"} 03:06:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:20 INFO - Contents: 03:06:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de37ab1fa38ac83e1677f67b4097192b943b002739b280f77f53f6f74702a55ba2ef7835acbd280088f3d0ef0b14302ee5a748deabdd1c9156fc34b19c9a0e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0e3006e00fe08c0ff132ceae76c7f725f8638ca450f365672f4041c9d8617bbc5bd173285de771d49ef72cf3639b2d99b82ea91f80c155a2357b018480fdd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b3c34b418e7e4146ab03e71c85d94d24e54d0849056953acc33a56deb40b29d9afcfcb68e4376b461369d7add0139995ccd19eaf7351c7f4b47c6904380da1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20cfc2d2089f495dcab758982894ddb6f5ddc8b08d40633c47352d7530a57ba0339b8f2d89377654c5a43507d17325c7ff753a0227ac514f45df2702ad72c8d"} 03:06:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:20 INFO - Copying logs to upload dir... 03:06:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.926803 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-11 03:06:20.205290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 03:06:20.208923) ========= 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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de37ab1fa38ac83e1677f67b4097192b943b002739b280f77f53f6f74702a55ba2ef7835acbd280088f3d0ef0b14302ee5a748deabdd1c9156fc34b19c9a0e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0e3006e00fe08c0ff132ceae76c7f725f8638ca450f365672f4041c9d8617bbc5bd173285de771d49ef72cf3639b2d99b82ea91f80c155a2357b018480fdd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b3c34b418e7e4146ab03e71c85d94d24e54d0849056953acc33a56deb40b29d9afcfcb68e4376b461369d7add0139995ccd19eaf7351c7f4b47c6904380da1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20cfc2d2089f495dcab758982894ddb6f5ddc8b08d40633c47352d7530a57ba0339b8f2d89377654c5a43507d17325c7ff753a0227ac514f45df2702ad72c8d"} build_url:https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010021 build_url: 'https://queue.taskcluster.net/v1/task/XqFR-xA9TjahZeOjA1L9Sg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de37ab1fa38ac83e1677f67b4097192b943b002739b280f77f53f6f74702a55ba2ef7835acbd280088f3d0ef0b14302ee5a748deabdd1c9156fc34b19c9a0e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a0e3006e00fe08c0ff132ceae76c7f725f8638ca450f365672f4041c9d8617bbc5bd173285de771d49ef72cf3639b2d99b82ea91f80c155a2357b018480fdd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92b3c34b418e7e4146ab03e71c85d94d24e54d0849056953acc33a56deb40b29d9afcfcb68e4376b461369d7add0139995ccd19eaf7351c7f4b47c6904380da1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20cfc2d2089f495dcab758982894ddb6f5ddc8b08d40633c47352d7530a57ba0339b8f2d89377654c5a43507d17325c7ff753a0227ac514f45df2702ad72c8d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 03:06:20.240565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 03:06:20.240900) ========= 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.KCTK4vdOg8/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.dQVUYhOfsb/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.004531 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 03:06:20.290131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 03:06:20.290480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 03:06:20.290886) ========= ========= Total master_lag: 0.20 =========