builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0369 starttime: 1491819796.13 results: success (0) buildid: 20170410013448 builduid: 60c879ef87c6486bb739f724947b807d revision: 731639fccc709a4dd95fed7e9dda88efb2227906 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.133556) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.134016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.134359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.159733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.160319) ========= 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.m2JoYdD8CN/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.npIDiEOSDU/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-10 03:23:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.11M=0.001s 2017-04-10 03:23:16 (9.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122379 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.308414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.308982) ========= 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.m2JoYdD8CN/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.npIDiEOSDU/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.021324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:16.359055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 03:23:16.359457) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 731639fccc709a4dd95fed7e9dda88efb2227906 --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 731639fccc709a4dd95fed7e9dda88efb2227906 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m2JoYdD8CN/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.npIDiEOSDU/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-10 03:23:16,443 truncating revision to first 12 chars 2017-04-10 03:23:16,443 Setting DEBUG logging. 2017-04-10 03:23:16,443 attempt 1/10 2017-04-10 03:23:16,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/731639fccc70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 03:23:18,168 unpacking tar archive at: mozilla-central-731639fccc70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.996103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-10 03:23:18.378151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:18.378570) ========= script_repo_revision: 731639fccc709a4dd95fed7e9dda88efb2227906 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:18.379063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:18.379408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 03:23:18.399301) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-10 03:23:18.399647) ========= /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.m2JoYdD8CN/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.npIDiEOSDU/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:23:18 INFO - MultiFileLogger online at 20170410 03:23:18 in /builds/slave/test 03:23:18 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 03:23:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:18 INFO - {'append_to_log': False, 03:23:18 INFO - 'base_work_dir': '/builds/slave/test', 03:23:18 INFO - 'blob_upload_branch': 'Firefox', 03:23:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:18 INFO - 'branch': 'Firefox', 03:23:18 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:18 INFO - 'config_files': ('talos/mac_config.py',), 03:23:18 INFO - 'default_actions': ('clobber', 03:23:18 INFO - 'read-buildbot-config', 03:23:18 INFO - 'download-and-extract', 03:23:18 INFO - 'populate-webroot', 03:23:18 INFO - 'create-virtualenv', 03:23:18 INFO - 'install', 03:23:18 INFO - 'run-tests'), 03:23:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:18 INFO - 'download_minidump_stackwalk': True, 03:23:18 INFO - 'download_symbols': 'ondemand', 03:23:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:18 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:18 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:18 INFO - 'gecko_profile': False, 03:23:18 INFO - 'gecko_profile_interval': 0, 03:23:18 INFO - 'installer_path': 'installer.exe', 03:23:18 INFO - 'log_level': 'info', 03:23:18 INFO - 'log_name': 'talos', 03:23:18 INFO - 'log_to_console': True, 03:23:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:23:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:23:18 INFO - 'opt_config_files': (), 03:23:18 INFO - 'pip_index': False, 03:23:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:18 INFO - 'cmd': ('bash', 03:23:18 INFO - '-c', 03:23:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:18 INFO - 'enabled': True, 03:23:18 INFO - 'halt_on_failure': False, 03:23:18 INFO - 'name': 'check_screen_resolution'},), 03:23:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:18 INFO - 'cmd': ('bash', 03:23:18 INFO - '-c', 03:23:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:18 INFO - 'enabled': True, 03:23:18 INFO - 'halt_on_failure': False, 03:23:18 INFO - 'name': 'check_screen_resolution'},), 03:23:18 INFO - 'run_cmd_checks_enabled': True, 03:23:18 INFO - 'suite': 'dromaeojs-e10s', 03:23:18 INFO - 'system_bits': '32', 03:23:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:18 INFO - 'title': 't-yosemite-r7-0369', 03:23:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:18 INFO - 'use_talos_json': True, 03:23:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:18 INFO - 'work_dir': 'build'} 03:23:18 INFO - [mozharness: 2017-04-10 10:23:18.613023Z] Running clobber step. 03:23:18 INFO - Running pre-action listener: _resource_record_pre_action 03:23:18 INFO - Running main action method: clobber 03:23:18 INFO - rmtree: /builds/slave/test/build 03:23:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:20 INFO - Running post-action listener: _resource_record_post_action 03:23:20 INFO - [mozharness: 2017-04-10 10:23:20.369427Z] Finished clobber step (success) 03:23:20 INFO - [mozharness: 2017-04-10 10:23:20.369591Z] Running read-buildbot-config step. 03:23:20 INFO - Running pre-action listener: _resource_record_pre_action 03:23:20 INFO - Running main action method: read_buildbot_config 03:23:20 INFO - Using buildbot properties: 03:23:20 INFO - { 03:23:20 INFO - "project": "", 03:23:20 INFO - "product": "firefox", 03:23:20 INFO - "script_repo_revision": "production", 03:23:20 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:23:20 INFO - "repository": "", 03:23:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:23:20 INFO - "buildid": "20170410013448", 03:23:20 INFO - "pgo_build": "False", 03:23:20 INFO - "basedir": "/builds/slave/test", 03:23:20 INFO - "buildnumber": 27, 03:23:20 INFO - "slavename": "t-yosemite-r7-0369", 03:23:20 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:23:20 INFO - "platform": "yosemite_r7", 03:23:20 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:23:20 INFO - "branch": "mozilla-central", 03:23:20 INFO - "repo_path": "mozilla-central", 03:23:20 INFO - "revision": "731639fccc709a4dd95fed7e9dda88efb2227906", 03:23:20 INFO - "stage_platform": "macosx64", 03:23:20 INFO - "builduid": "60c879ef87c6486bb739f724947b807d", 03:23:20 INFO - "slavebuilddir": "test" 03:23:20 INFO - } 03:23:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:23:20 INFO - Running post-action listener: _resource_record_post_action 03:23:20 INFO - [mozharness: 2017-04-10 10:23:20.373042Z] Finished read-buildbot-config step (success) 03:23:20 INFO - [mozharness: 2017-04-10 10:23:20.373149Z] Running download-and-extract step. 03:23:20 INFO - Running pre-action listener: _resource_record_pre_action 03:23:20 INFO - Running main action method: download_and_extract 03:23:20 INFO - mkdir: /builds/slave/test/build/tests 03:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:20 INFO - trying https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:23:20 INFO - Downloading https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/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 03:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/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 03:23:21 INFO - Downloaded 1325 bytes. 03:23:21 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:23:21 INFO - Using the following test package requirements: 03:23:21 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:23:21 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:23:21 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:23:21 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:23:21 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'jsshell-mac.zip'], 03:23:21 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:23:21 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:23:21 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:23:21 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:23:21 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:23:21 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:21 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:23:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:23:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:23:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:23:21 INFO - Fetch https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:23:23 INFO - Expected file size: 52580584 03:23:23 INFO - Obtained file size: 52580584 03:23:39 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 03:23:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:23:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:23:39 INFO - Fetch https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:23:41 INFO - Expected file size: 52580584 03:23:41 INFO - Obtained file size: 52580584 03:23:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:23:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:23:57 INFO - Fetch https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:23:58 INFO - Expected file size: 14405596 03:23:58 INFO - Obtained file size: 14405596 03:23: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')]} 03:23:58 INFO - trying https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:23:58 INFO - Downloading https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/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 03:24:00 INFO - Downloaded 70966596 bytes. 03:24:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:24:00 INFO - mkdir: /builds/slave/test/properties 03:24:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:00 INFO - Contents: 03:24:00 INFO - build_url:https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:24:01 INFO - Running post-action listener: _resource_record_post_action 03:24:01 INFO - Running post-action listener: set_extra_try_arguments 03:24:01 INFO - [mozharness: 2017-04-10 10:24:01.532310Z] Finished download-and-extract step (success) 03:24:01 INFO - [mozharness: 2017-04-10 10:24:01.532448Z] Running populate-webroot step. 03:24:01 INFO - Running pre-action listener: _resource_record_pre_action 03:24:01 INFO - Running main action method: populate_webroot 03:24:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:01 INFO - '--tppagecycles', 03:24:01 INFO - '7'], 03:24:01 INFO - 'tests': ['tsvgm']}}, 03:24:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['damp', 'tps']}, 03:24:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'tests': ['damp', 'tps']}, 03:24:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['dromaeo_dom']}, 03:24:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['basic_compositor_video']}, 03:24:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:24:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['a11yr', 03:24:01 INFO - 'ts_paint', 03:24:01 INFO - 'tpaint', 03:24:01 INFO - 'sessionrestore', 03:24:01 INFO - 'sessionrestore_no_auto_restore', 03:24:01 INFO - 'tabpaint']}, 03:24:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:01 INFO - 'ts_paint', 03:24:01 INFO - 'tpaint', 03:24:01 INFO - 'sessionrestore', 03:24:01 INFO - 'sessionrestore_no_auto_restore', 03:24:01 INFO - 'tabpaint']}, 03:24:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:01 INFO - 'ts_paint', 03:24:01 INFO - 'tpaint', 03:24:01 INFO - 'sessionrestore', 03:24:01 INFO - 'sessionrestore_no_auto_restore', 03:24:01 INFO - 'tabpaint']}, 03:24:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:01 INFO - 'ts_paint', 03:24:01 INFO - 'tpaint', 03:24:01 INFO - 'sessionrestore', 03:24:01 INFO - 'sessionrestore_no_auto_restore', 03:24:01 INFO - 'tabpaint']}, 03:24:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['a11yr', 03:24:01 INFO - 'ts_paint', 03:24:01 INFO - 'tpaint', 03:24:01 INFO - 'sessionrestore', 03:24:01 INFO - 'sessionrestore_no_auto_restore', 03:24:01 INFO - 'tabpaint']}, 03:24:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['a11yr', 03:24:01 INFO - 'ts_paint', 03:24:01 INFO - 'tpaint', 03:24:01 INFO - 'sessionrestore', 03:24:01 INFO - 'sessionrestore_no_auto_restore', 03:24:01 INFO - 'tabpaint']}, 03:24:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['tsvgx', 03:24:01 INFO - 'tsvgr_opacity', 03:24:01 INFO - 'tart', 03:24:01 INFO - 'tscrollx', 03:24:01 INFO - 'cart', 03:24:01 INFO - 'tsvg_static']}, 03:24:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:01 INFO - 'tsvgr_opacity', 03:24:01 INFO - 'tart', 03:24:01 INFO - 'tscrollx', 03:24:01 INFO - 'cart', 03:24:01 INFO - 'tsvg_static']}, 03:24:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'talos_options': ['--disable-e10s'], 03:24:01 INFO - 'tests': ['tp5o']}, 03:24:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:24:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'talos_options': ['--disable-e10s', 03:24:01 INFO - '--xperf_path', 03:24:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:01 INFO - 'tests': ['tp5n']}, 03:24:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:24:01 INFO - 'talos_options': ['--xperf_path', 03:24:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:01 INFO - 'tests': ['tp5n']}}, 03:24:01 INFO - 'talos.zip': {'path': '', 03:24:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:01 INFO - Running post-action listener: _resource_record_post_action 03:24:01 INFO - [mozharness: 2017-04-10 10:24:01.550760Z] Finished populate-webroot step (success) 03:24:01 INFO - [mozharness: 2017-04-10 10:24:01.550868Z] Running create-virtualenv step. 03:24:01 INFO - Running pre-action listener: _resource_record_pre_action 03:24:01 INFO - Running main action method: create_virtualenv 03:24:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:01 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 03:24:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:01 INFO - Using real prefix '/tools/python27' 03:24:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:05 INFO - Installing pip.................done. 03:24:05 INFO - Return code: 0 03:24:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:24:05 INFO - Reading from file tmpfile_stdout 03:24:05 INFO - Output received: 03:24:05 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) 03:24:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:05 INFO - 'HOME': '/Users/cltbld', 03:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:05 INFO - 'LOGNAME': 'cltbld', 03:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:05 INFO - 'MOZ_NO_REMOTE': '1', 03:24:05 INFO - 'NO_EM_RESTART': '1', 03:24:05 INFO - 'PAGER': '/bin/cat', 03:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:05 INFO - 'PWD': '/builds/slave/test', 03:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:05 INFO - 'SHELL': '/bin/bash', 03:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:05 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:05 INFO - 'USER': 'cltbld', 03:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:05 INFO - 'XPC_FLAGS': '0x0', 03:24:05 INFO - 'XPC_SERVICE_NAME': '0', 03:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:05 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 03:24:05 INFO - Cleaning up... 03:24:05 INFO - Return code: 0 03:24:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:05 INFO - 'HOME': '/Users/cltbld', 03:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:05 INFO - 'LOGNAME': 'cltbld', 03:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:05 INFO - 'MOZ_NO_REMOTE': '1', 03:24:05 INFO - 'NO_EM_RESTART': '1', 03:24:05 INFO - 'PAGER': '/bin/cat', 03:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:05 INFO - 'PWD': '/builds/slave/test', 03:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:05 INFO - 'SHELL': '/bin/bash', 03:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:05 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:05 INFO - 'USER': 'cltbld', 03:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:05 INFO - 'XPC_FLAGS': '0x0', 03:24:05 INFO - 'XPC_SERVICE_NAME': '0', 03:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:06 INFO - Downloading/unpacking psutil>=3.1.1 03:24:06 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 03:24:06 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 03:24:06 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 03:24:06 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 03:24:06 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 03:24:06 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 03:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:09 INFO - Installing collected packages: psutil 03:24:09 INFO - Running setup.py install for psutil 03:24:09 INFO - building 'psutil._psutil_osx' extension 03:24:09 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 03:24:10 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 03:24:10 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 03:24:10 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 03:24:10 INFO - building 'psutil._psutil_posix' extension 03:24:10 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 03:24:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:24:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:24:10 INFO - ^ 03:24:10 INFO - 1 warning generated. 03:24:10 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 03:24:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:10 INFO - Successfully installed psutil 03:24:10 INFO - Cleaning up... 03:24:10 INFO - Return code: 0 03:24:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:10 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:10 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 03:24:10 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 03:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:10 INFO - 'HOME': '/Users/cltbld', 03:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:10 INFO - 'LOGNAME': 'cltbld', 03:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:10 INFO - 'MOZ_NO_REMOTE': '1', 03:24:10 INFO - 'NO_EM_RESTART': '1', 03:24:10 INFO - 'PAGER': '/bin/cat', 03:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:10 INFO - 'PWD': '/builds/slave/test', 03:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:10 INFO - 'SHELL': '/bin/bash', 03:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:10 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:10 INFO - 'USER': 'cltbld', 03:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:10 INFO - 'XPC_FLAGS': '0x0', 03:24:10 INFO - 'XPC_SERVICE_NAME': '0', 03:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:13 INFO - Installing collected packages: mozsystemmonitor 03:24:13 INFO - Running setup.py install for mozsystemmonitor 03:24:13 INFO - Successfully installed mozsystemmonitor 03:24:13 INFO - Cleaning up... 03:24:13 INFO - Return code: 0 03:24:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24: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==2.5.1'] in /builds/slave/test/build 03:24: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==2.5.1 03:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:14 INFO - 'HOME': '/Users/cltbld', 03:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:14 INFO - 'LOGNAME': 'cltbld', 03:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:14 INFO - 'MOZ_NO_REMOTE': '1', 03:24:14 INFO - 'NO_EM_RESTART': '1', 03:24:14 INFO - 'PAGER': '/bin/cat', 03:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:14 INFO - 'PWD': '/builds/slave/test', 03:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:14 INFO - 'SHELL': '/bin/bash', 03:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:14 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:14 INFO - 'USER': 'cltbld', 03:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:14 INFO - 'XPC_FLAGS': '0x0', 03:24:14 INFO - 'XPC_SERVICE_NAME': '0', 03:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:24:14 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 03:24:14 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 03:24:14 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 03:24:14 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 03:24:14 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 03:24:14 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 03:24:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:17 INFO - warning: no files found matching '*.txt' 03:24:17 INFO - no previously-included directories found matching 'build' 03:24:17 INFO - no previously-included directories found matching 'dist' 03:24:17 INFO - no previously-included directories found matching '.git*' 03:24:17 INFO - Installing collected packages: jsonschema, functools32 03:24:17 INFO - Running setup.py install for functools32 03:24:18 INFO - warning: no files found matching '*.txt' 03:24:18 INFO - no previously-included directories found matching 'build' 03:24:18 INFO - no previously-included directories found matching 'dist' 03:24:18 INFO - no previously-included directories found matching '.git*' 03:24:18 INFO - Successfully installed jsonschema functools32 03:24:18 INFO - Cleaning up... 03:24:18 INFO - Return code: 0 03:24:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:18 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:18 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 03:24:18 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 03:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:18 INFO - 'HOME': '/Users/cltbld', 03:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:18 INFO - 'LOGNAME': 'cltbld', 03:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:18 INFO - 'MOZ_NO_REMOTE': '1', 03:24:18 INFO - 'NO_EM_RESTART': '1', 03:24:18 INFO - 'PAGER': '/bin/cat', 03:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:18 INFO - 'PWD': '/builds/slave/test', 03:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:18 INFO - 'SHELL': '/bin/bash', 03:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:18 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:18 INFO - 'USER': 'cltbld', 03:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:18 INFO - 'XPC_FLAGS': '0x0', 03:24:18 INFO - 'XPC_SERVICE_NAME': '0', 03:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:24:18 INFO - Cleaning up... 03:24:18 INFO - Return code: 0 03:24:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:18 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:18 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 03:24:18 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 03:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:18 INFO - 'HOME': '/Users/cltbld', 03:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:18 INFO - 'LOGNAME': 'cltbld', 03:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:18 INFO - 'MOZ_NO_REMOTE': '1', 03:24:18 INFO - 'NO_EM_RESTART': '1', 03:24:18 INFO - 'PAGER': '/bin/cat', 03:24:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:18 INFO - 'PWD': '/builds/slave/test', 03:24:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:18 INFO - 'SHELL': '/bin/bash', 03:24:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:18 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:18 INFO - 'USER': 'cltbld', 03:24:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:18 INFO - 'XPC_FLAGS': '0x0', 03:24:18 INFO - 'XPC_SERVICE_NAME': '0', 03:24:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:18 INFO - Downloading/unpacking blobuploader==1.2.4 03:24:18 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 03:24:18 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 03:24:18 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 03:24:18 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 03:24:18 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 03:24:18 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 03:24:21 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 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 03:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:22 INFO - Downloading docopt-0.6.1.tar.gz 03:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:22 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:22 INFO - Running setup.py install for blobuploader 03:24:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:22 INFO - Running setup.py install for requests 03:24:23 INFO - Running setup.py install for docopt 03:24:23 INFO - Successfully installed blobuploader requests docopt 03:24:23 INFO - Cleaning up... 03:24:23 INFO - Return code: 0 03:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:23 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:23 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 03:24:23 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 03:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:23 INFO - 'HOME': '/Users/cltbld', 03:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:23 INFO - 'LOGNAME': 'cltbld', 03:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:23 INFO - 'MOZ_NO_REMOTE': '1', 03:24:23 INFO - 'NO_EM_RESTART': '1', 03:24:23 INFO - 'PAGER': '/bin/cat', 03:24:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:23 INFO - 'PWD': '/builds/slave/test', 03:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:23 INFO - 'SHELL': '/bin/bash', 03:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:23 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:23 INFO - 'USER': 'cltbld', 03:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:23 INFO - 'XPC_FLAGS': '0x0', 03:24:23 INFO - 'XPC_SERVICE_NAME': '0', 03:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:23 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-R5Kv99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:23 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-PYdUyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Lxb_Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-eR8QdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-iBiUM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-O_m0Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-K1e8Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-VrUTeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-h6_Tlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-8hnsAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-DLmmu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:24 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-KeFZIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-22PHNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-eNLKbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-WvstQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pqIL6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:25 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-RoWocu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:25 INFO - Running setup.py install for manifestparser 03:24:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:25 INFO - Running setup.py install for mozcrash 03:24:25 INFO - Running setup.py install for mozdebug 03:24:25 INFO - Running setup.py install for mozdevice 03:24:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Running setup.py install for mozfile 03:24:26 INFO - Running setup.py install for mozhttpd 03:24:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Running setup.py install for mozinfo 03:24:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Running setup.py install for mozInstall 03:24:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:26 INFO - Running setup.py install for mozleak 03:24:26 INFO - Running setup.py install for mozlog 03:24:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:27 INFO - Running setup.py install for moznetwork 03:24:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:27 INFO - Running setup.py install for mozprocess 03:24:27 INFO - Running setup.py install for mozprofile 03:24:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:27 INFO - Running setup.py install for mozrunner 03:24:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:27 INFO - Running setup.py install for mozscreenshot 03:24:27 INFO - Running setup.py install for moztest 03:24:27 INFO - Running setup.py install for mozversion 03:24:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:28 INFO - Cleaning up... 03:24:28 INFO - Return code: 0 03:24:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:28 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:28 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 03:24:28 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 03:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:28 INFO - 'HOME': '/Users/cltbld', 03:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:28 INFO - 'LOGNAME': 'cltbld', 03:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:28 INFO - 'MOZ_NO_REMOTE': '1', 03:24:28 INFO - 'NO_EM_RESTART': '1', 03:24:28 INFO - 'PAGER': '/bin/cat', 03:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:28 INFO - 'PWD': '/builds/slave/test', 03:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:28 INFO - 'SHELL': '/bin/bash', 03:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:28 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:28 INFO - 'USER': 'cltbld', 03:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:28 INFO - 'XPC_FLAGS': '0x0', 03:24:28 INFO - 'XPC_SERVICE_NAME': '0', 03:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:28 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-AIBQ6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:28 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)) 03:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:28 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pvrMWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:28 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)) 03:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:28 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-5Vpkp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:28 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)) 03:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:28 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-GQpV2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:28 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)) 03:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:28 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-oJKsw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:28 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)) 03:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:28 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Ppvp4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-nCB38j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-ohxaRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-kJpkqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-K95A5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-xaE8cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-kUi4uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-tjIw_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-_mpO1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:29 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)) 03:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-dKf190-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:30 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)) 03:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-_t1IYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:30 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)) 03:24:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-y2dLpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:30 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)) 03:24:30 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)) 03:24:30 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)) 03:24:30 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)) 03:24:30 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)) 03:24:30 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)) 03:24:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:30 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 03:24:30 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 03:24:30 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 03:24:30 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 03:24:30 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 03:24:30 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 03:24:32 INFO - Downloading blessings-1.6.tar.gz 03:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:32 INFO - Installing collected packages: blessings 03:24:32 INFO - Running setup.py install for blessings 03:24:33 INFO - Successfully installed blessings 03:24:33 INFO - Cleaning up... 03:24:33 INFO - Return code: 0 03:24:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:33 INFO - Reading from file tmpfile_stdout 03:24:33 INFO - Current package versions: 03:24:33 INFO - blessings == 1.6 03:24:33 INFO - blobuploader == 1.2.4 03:24:33 INFO - docopt == 0.6.1 03:24:33 INFO - functools32 == 3.2.3-2 03:24:33 INFO - jsonschema == 2.5.1 03:24:33 INFO - manifestparser == 1.1 03:24:33 INFO - mozInstall == 1.12 03:24:33 INFO - mozcrash == 1.0 03:24:33 INFO - mozdebug == 0.1 03:24:33 INFO - mozdevice == 0.50 03:24:33 INFO - mozfile == 1.2 03:24:33 INFO - mozhttpd == 0.7 03:24:33 INFO - mozinfo == 0.9 03:24:33 INFO - mozleak == 0.1 03:24:33 INFO - mozlog == 3.4 03:24:33 INFO - moznetwork == 0.27 03:24:33 INFO - mozprocess == 0.25 03:24:33 INFO - mozprofile == 0.28 03:24:33 INFO - mozrunner == 6.13 03:24:33 INFO - mozscreenshot == 0.1 03:24:33 INFO - mozsystemmonitor == 0.3 03:24:33 INFO - moztest == 0.8 03:24:33 INFO - mozversion == 1.4 03:24:33 INFO - psutil == 3.1.1 03:24:33 INFO - requests == 1.2.3 03:24:33 INFO - wsgiref == 0.1.2 03:24:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:33 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')]} 03:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:33 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')]} 03:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:33 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:33 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 03:24:33 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 03:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:33 INFO - 'HOME': '/Users/cltbld', 03:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:33 INFO - 'LOGNAME': 'cltbld', 03:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:33 INFO - 'MOZ_NO_REMOTE': '1', 03:24:33 INFO - 'NO_EM_RESTART': '1', 03:24:33 INFO - 'PAGER': '/bin/cat', 03:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:33 INFO - 'PWD': '/builds/slave/test', 03:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:33 INFO - 'SHELL': '/bin/bash', 03:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:33 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:33 INFO - 'USER': 'cltbld', 03:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:33 INFO - 'XPC_FLAGS': '0x0', 03:24:33 INFO - 'XPC_SERVICE_NAME': '0', 03:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 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)) 03:24:33 INFO - Cleaning up... 03:24:33 INFO - Return code: 0 03:24:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:33 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')]} 03:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:33 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')]} 03:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:33 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 0x106758b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10675b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94aa57bc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, '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.m2JoYdD8CN/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.npIDiEOSDU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 03:24:33 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 03:24:33 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 03:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:33 INFO - 'HOME': '/Users/cltbld', 03:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:33 INFO - 'LOGNAME': 'cltbld', 03:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:33 INFO - 'MOZ_NO_REMOTE': '1', 03:24:33 INFO - 'NO_EM_RESTART': '1', 03:24:33 INFO - 'PAGER': '/bin/cat', 03:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:33 INFO - 'PWD': '/builds/slave/test', 03:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:33 INFO - 'SHELL': '/bin/bash', 03:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:33 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:33 INFO - 'USER': 'cltbld', 03:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:33 INFO - 'XPC_FLAGS': '0x0', 03:24:33 INFO - 'XPC_SERVICE_NAME': '0', 03:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:34 INFO - Cleaning up... 03:24:34 INFO - Return code: 0 03:24:34 INFO - Running post-action listener: _resource_record_post_action 03:24:34 INFO - Running post-action listener: _start_resource_monitoring 03:24:34 INFO - Starting resource monitoring. 03:24:34 INFO - [mozharness: 2017-04-10 10:24:34.081571Z] Finished create-virtualenv step (success) 03:24:34 INFO - [mozharness: 2017-04-10 10:24:34.082479Z] Running install step. 03:24:34 INFO - Running pre-action listener: _resource_record_pre_action 03:24:34 INFO - Running main action method: install 03:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:34 INFO - Reading from file tmpfile_stdout 03:24:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:34 INFO - Reading from file tmpfile_stdout 03:24:34 INFO - Output received: 03:24:34 INFO - Usage: mozinstall [options] installer 03:24:34 INFO - Options: 03:24:34 INFO - -h, --help show this help message and exit 03:24:34 INFO - -d DEST, --destination=DEST 03:24:34 INFO - Directory to install application into. [default: 03:24:34 INFO - "/builds/slave/test"] 03:24:34 INFO - --app=APP Application being installed. [default: firefox] 03:24:34 INFO - mkdir: /builds/slave/test/build/application 03:24:34 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'] 03:24:34 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 03:24:54 INFO - Reading from file tmpfile_stdout 03:24:54 INFO - Output received: 03:24:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:24:54 INFO - Running post-action listener: _resource_record_post_action 03:24:54 INFO - [mozharness: 2017-04-10 10:24:54.115738Z] Finished install step (success) 03:24:54 INFO - [mozharness: 2017-04-10 10:24:54.115902Z] Running run-tests step. 03:24:54 INFO - Running pre-action listener: _resource_record_pre_action 03:24:54 INFO - Running main action method: run_tests 03:24:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:54 INFO - 2017-04-10 03:24:54.130 screenresolution[1916:16431] starting screenresolution argv=screenresolution get 03:24:54 INFO - 2017-04-10 03:24:54.133 screenresolution[1916:16431] Display 0: 1600x1200x32@60 03:24:54 INFO - 2017-04-10 03:24:54.139 screenresolution[1917:16435] starting screenresolution argv=screenresolution list 03:24:54 INFO - Available Modes on Display 0 03:24:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:54 INFO - Intel Iris: 03:24:54 INFO - Chipset Model: Intel Iris 03:24:54 INFO - Type: GPU 03:24:54 INFO - Bus: Built-In 03:24:54 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:54 INFO - Vendor: Intel (0x8086) 03:24:54 INFO - Device ID: 0x0a2e 03:24:54 INFO - Revision ID: 0x0009 03:24:54 INFO - Displays: 03:24:54 INFO - Display: 03:24:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:54 INFO - Display Serial Number: 1600x1200 60 03:24:54 INFO - Main Display: Yes 03:24:54 INFO - Mirror: Off 03:24:54 INFO - Online: Yes 03:24:54 INFO - Rotation: Supported 03:24:54 INFO - Return code: 0 03:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:54 INFO - Python 2.7.3 03:24:54 INFO - Return code: 0 03:24:54 INFO - grabbing minidump binary from tooltool 03:24: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')]} 03:24:54 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 0x106536d30>, '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 0x10645ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10652bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:54 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 03:24:54 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 03:24:54 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 03:24:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:54 INFO - Return code: 0 03:24:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:24:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:54 INFO - ENV: RUST_BACKTRACE is now 1 03:24:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:24:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:54 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/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--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 03:24:54 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/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0369 --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 03:24:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m2JoYdD8CN/Render', 03:24:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:54 INFO - 'HOME': '/Users/cltbld', 03:24:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:54 INFO - 'LOGNAME': 'cltbld', 03:24:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:54 INFO - 'MOZ_NO_REMOTE': '1', 03:24:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:54 INFO - 'NO_EM_RESTART': '1', 03:24:54 INFO - 'PAGER': '/bin/cat', 03:24:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:54 INFO - 'PWD': '/builds/slave/test', 03:24:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:54 INFO - 'RUST_BACKTRACE': '1', 03:24:54 INFO - 'SHELL': '/bin/bash', 03:24:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.npIDiEOSDU/Listeners', 03:24:54 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 03:24:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:54 INFO - 'USER': 'cltbld', 03:24:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:54 INFO - 'XPC_FLAGS': '0x0', 03:24:54 INFO - 'XPC_SERVICE_NAME': '0', 03:24:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:54 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/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--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 03:24:54 INFO - mozversion application_buildid: 20170410013448 03:24:54 INFO - mozversion application_changeset: 731639fccc709a4dd95fed7e9dda88efb2227906 03:24:54 INFO - mozversion application_display_name: Nightly 03:24:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:54 INFO - mozversion application_name: Firefox 03:24:54 INFO - mozversion application_remotingname: firefox 03:24:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:24:54 INFO - mozversion application_vendor: Mozilla 03:24:54 INFO - mozversion application_version: 55.0a1 03:24:54 INFO - mozversion platform_buildid: 20170410013448 03:24:54 INFO - mozversion platform_changeset: 731639fccc709a4dd95fed7e9dda88efb2227906 03:24:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:24:54 INFO - mozversion platform_version: 55.0a1 03:24:54 INFO - using testdate: 1491819894 03:24:54 INFO - actual date: 1491819894 03:24:54 INFO - starting webserver on 'localhost:53440' 03:24:54 INFO - SUITE-START | Running 2 tests 03:24:54 INFO - TEST-START | dromaeo_css 03:24:54 INFO - operating with platform_type : mac_ 03:24:54 INFO - Initialising browser for dromaeo_css test... 03:24:54 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpscMdbD/profile http://localhost:53440/getInfo.html) 03:24:57 INFO - PID 1927 | 2017-04-10 03:24:57.933 plugin-container[1929:16600] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c4b, name = 'com.apple.tsm.portname' 03:24:57 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:24:57 INFO - PID 1927 | 2017-04-10 03:24:57.935 plugin-container[1929:16600] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 03:24:57 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:24:57 INFO - PID 1927 | 2017-04-10 03:24:57.935 plugin-container[1929:16600] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:24:58 INFO - PID 1927 | __metrics Screen width/height:1600/1200 03:24:58 INFO - PID 1927 | colorDepth:24 03:24:58 INFO - PID 1927 | Browser inner width/height: 1024/689 03:24:58 INFO - PID 1927 | __metrics 03:24:58 ERROR - PID 1927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 03:24:59 INFO - TEST-INFO | 1927: exit 0 03:24:59 INFO - Browser initialized. 03:24:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:59 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpscMdbD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:01 INFO - PID 1930 | 2017-04-10 03:25:01.694 plugin-container[1931:16731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 03:25:01 INFO - PID 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:25:01 INFO - PID 1930 | 2017-04-10 03:25:01.695 plugin-container[1931:16731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 03:25:01 INFO - PID 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:25:01 INFO - PID 1930 | 2017-04-10 03:25:01.695 plugin-container[1931:16731] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:25:11 INFO - PID 1930 | RSS: Main: 233955328 03:25:11 INFO - PID 1930 | 03:28:15 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:53440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53440/tests/dromaeo/cssquery-ext.html) 03:28:16 INFO - PID 1930 | RSS: Main: 252133376 03:28:16 INFO - PID 1930 | 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 03:29:59 INFO - PID 1930 | 03:29:59 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:29:59 INFO - PID 1930 | Full stack: 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 03:29:59 INFO - PID 1930 | 03:29:59 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:29:59 INFO - PID 1930 | Full stack: 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 03:29:59 INFO - PID 1930 | 03:29:59 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:29:59 INFO - PID 1930 | Full stack: 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | ************************* 03:29:59 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 03:29:59 INFO - PID 1930 | 03:29:59 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:29:59 INFO - PID 1930 | Full stack: 03:29:59 INFO - PID 1930 | ************************* 03:31:18 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:53440/tests/dromaeo/cssquery-ext.html (next: http://localhost:53440/tests/dromaeo/cssquery-jquery.html) 03:31:19 INFO - PID 1930 | RSS: Main: 263135232 03:31:19 INFO - PID 1930 | 03:34:21 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:53440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53440/tests/dromaeo/cssquery-mootools.html) 03:34:21 INFO - PID 1930 | RSS: Main: 275279872 03:34:21 INFO - PID 1930 | 03:37:23 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:53440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53440/tests/dromaeo/cssquery-prototype.html) 03:37:24 INFO - PID 1930 | RSS: Main: 267784192 03:37:24 INFO - PID 1930 | 03:40:26 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:53440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53440/tests/dromaeo/cssquery-yui.html) 03:40:27 INFO - PID 1930 | RSS: Main: 278224896 03:40:27 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:53440/tests/dromaeo/cssquery-yui.html (next: http://localhost:53440/tests/dromaeo/cssquery-dojo.html) 03:43:29 INFO - PID 1930 | RSS: Main: 272244736 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | __start_tp_report 03:43:29 INFO - PID 1930 | _x_x_mozilla_page_load 03:43:29 INFO - PID 1930 | _x_x_mozilla_page_load_details 03:43:29 INFO - PID 1930 | |i|pagename|runs| 03:43:29 INFO - PID 1930 | |0;dojo.html;3374.5613070300856;3398.082517720215;3534.2754735279254;3554.147004718868;3575.2849430113965;6027.849303767408;6179.351168127349;6194.132821405001;6210.906836397452;6247.7813276535335;6082.756689732405;6105.633661980273;6136.539759518043;6140.754369825213;6187.783427580036;5424.945750542503;5436.103042997901;5506.091494903336;5507.889842203173;5567.832965011036;5370.355557333126;5517.917231241535;5518.944810551903;5532.834014979537;5542.1132618781;5435.782568697267;5488.9725551372185;5535.308086489189;5538.6399884007415;5546.306711661043;4620.53794620537;5327.600429967768;5373.7581808818695;5466.726663666801;5495.560355171617;5289.523942845162;5319.840404787863;5329.360476742816;5377.784888604451;5398.2712333834825;5145;6198.101275315099;6210;6216.844578885519;6260.405261500196;6614.7684831031165;6668.199816022108;6681.198256209237;6689.531732778707;6705.195376554844;6388.137601423795;6476.676166191672;6572.86854262912;6789.558678685919;6795.592264464148;6297.527685423565;6310.652914089677;6335.303116657164;6359.332270111664;6360.077788720656;6756.121704178524;6886;6908.205556361083;6914.619695916672;6922.03091567181;6278.968605156945;6338.080978258126;6485.1245081914285;6528.934710652928;6541.738330466728;6538.248101468392;6631.535792494576;6646.86706265872;6673.933260667428;6686.598804071771;5426.375966763794;6545.083688283644;6570.211574611078;6573.769918052941;6583.670816459158;6312.368763123743;6361.395667411589;6498.5126115541525;6547.410733034049;6582.210134783761;5305.44292849253;5323.30796996388;5324.866878327995;5327.520523152857;5391.29913111293;4656.301554766812;4658.813647454132;4662.323963025342;4673;4699.835505757282;6186.536009799283;6357.332480089524;6376.617402955838;6383.521235907326;6393.584417012879;6442.162518872517;6614.140161779034;6685.966570167118;6720.361565651256;6743.224529179109;6311.842203944938;6335.493160547145;6338.334474880164;6346.397092276226;6360.9045864312075;5854.238948936696;5862.091375836752;5876.44173803488;5890.970545147246;5903.734331955073;5264.605154613343;6501.0573466847045;6564.606123632598;6795.456363491007;6832.111825462658;6762.391384775394;6765.086713293643;6769.830754231184;6784.6946887389195;6793.966030170015;5503.587230957614;6605.471562275103;6701.966490167518;6904.27505111956;6920.826979325557;6406.23125224976;6501.9674901625185;6502.057201705821;6531.314212007671;6540.705668244846;5585.525230355465;6586.715590459814;6662.233843108104;6667.66661666905;6689.933100668931;5481.369642491165;6276.6547839869245;6376.585521941244;6410.134631824644;6412.454941329853;6252.218472690914;6410.647414392253;6462.5153113515735;6487.318831522811;6494.4804415645685;6290.0879372491645;6304.401081897213;6327.050942358683;6405.487560995202;6413.839654008687;6387.914054610635;6518.869622607426;6544.901826472512;6549.574277671936;6553.737850485927;6192.690365481798;6247.468965138014;6260.311365749855;6281.246250449975;6289.654069026247 03:43:29 INFO - PID 1930 | |1;ext.html;728.3262981741888;796.4186144114796;823.7240524424316;1273.8280332155161;1277.584784944893;23045.76954230459;32142.839285803566;32159.67840321596;32240.67759322406;32246;38535.80732096336;38794.418083728764;38813.61186388135;38869.80565097178;38871.805640971754;7997.680092796281;8127.512349259034;8411.747647570583;8686.739397818075;8713.607887645072;8688.218060374566;8770.912290877106;8783.472991620523;8789.736307910742;8807.427517211361;8713.259372953275;8796;8800.295976321879;8811.77970550738;8829.779255518599;8751.081136480641;8775.956120219422;8777.780555486132;8786.29709623235;8800.559972001407;8541.786455338604;8614.698485552975;8616.569171541461;8625.008124065687;8636.0932102129;37885.810570947244;38032.61967380346;38072.42891356632;38150.42774358387;38193.045173870596;3618.583862855779;3640.271945610862;3651.087228192952;3663.358912190383;3664.5236119304586;31158;31197.688023119706;31215.84392078025;31235.843820780978;31266.43667816623;3157.226479512511;3185.0285662872816;3191.776575639706;3196.3127927495466;3199.2161920329436;229939;234730;261737;285413;286948.5652571745;47064.76467617709;47353;47383.314002319945;47405.5259447408;47541.04917901692;49404.50595493999;49676.254856177184;49748.253776193385;49834.75082624636;49979;14130.576082717535;14204.005719599736;14204.644883877985;14240.074395164489;14261.504236758527;11703.356315402734;11705.531778728755;11729;11745.706357340963;11762.70593235176;13599.456021759019;13670.52153174634;13671.086047953295;13699.45202191921;13761.724765504634;5065.873353166126;5445.53712934405;5858.5898987070495;6094.329623741385;6130.938690613126;909.9181073703398;979.1285755677453;1024.800163968019;1030.5156576409076;1036.2435422141727;22679.546409071725;23916.88041559781;24517.141900033414;24643.507129857302;24644.507109857703;1004.8392257238806;1152.5505053029326;1153.256781229482;1153.3887039868882;1158.0966845860241;12612.117151799286;12615.18001329929;12629.684257893443;12664.176828506303;12742.171758835646;370564;372749;373850.13074934995;374613;374637;53664.46335536673;53702.65743356448;53736;53749;53821;1491.970160596782;1513.8259100203397;1553.3631211203353;1556.9532914012598;1560.4070453227928;23963.28110156698;24070.759292406852;24197.63703544413;24207.789610519754;24624.50750985006;38116.04709882275;38390.808045959595;38433.2313353737;38449.42325865058;38487.6151238484;312515;313873;316254;316955;317573.76983610925;27595.86202068977;34423.655763442046;35210.8239458801;35335.64664353323;35705.64294357127;45346.319805202285;46311;46383.76808115938;46392.76803616095;46428.071438571715;30217.848910755307;30439.847800760854;30762.230944226572;31483.583238753854;31898.84050579732;30529.38941221119;31379.686203137677;31457;31491.212719682193;31740.682593173773;37458;37478.252174782305;37595.24809503849;37595.81202093972;37620.247595047396;30128.849355753082;30747.692523074482;31287.374252514368;32096.67903320937;32380;18808.24767009359;24446.388840279134;24690.13584524533;24886.626700599143;24936.750632494168 03:43:29 INFO - PID 1930 | |2;jquery.html;394.8716667083197;422.8837069805805;424.75576543487483;430.75877508595187;446.2502994968454;20007.89956552389;21641.56716865664;22215.333539993786;22396.440088997744;22539.661905071436;22090;22671;22880.88559557204;22944.196953106646;23441.765582344215;4941.937483441059;5030.0694371541385;6199.44205021548;6409.423151916327;6432.195975503062;5660.60375773696;5973.163757074013;6246.562740608159;6393.648349340784;6430.292667806538;6141.447269745722;6370.936290637103;6384.3934826191435;6407.935920640781;6425.518086143535;5382.2195781611645;6221.720022598994;6357.459615932651;6369.8407539811415;6371.617702937792;5394.217838413408;5566.693831839248;5626.240457538221;5633.042382794934;5639.71801409932;26113.216603501736;26498.470030599474;26499.867500662567;26777.330566735793;26964.056258031073;2009.8191162795272;2203.4711669199437;2272.522770218256;2285.737140228878;2287.08516593364;15555.300011499396;17678.292868285254;17689.29242830285;17787.911060444745;18234.452966410896;2150.892455377225;2190.09111218844;2223.3885681437573;2229.6321107017325;2233.9218127365625;145373;145885.27057364752;145947;146076;153299.7005044914;10083.294169408218;11777.234479758788;12254.38728063611;12256.754864902652;12683.556075537312;16157.353705851869;16241.106739129462;16247.350105995627;16253.10607916576;16298;8746.256568191775;8968.372213944962;9017.368784185044;9027.684031058881;9126.45241285525;6919.238883722786;8483.236508714246;8502.362322825813;8632.007319158252;8636.956815215884;7695.653695583712;7767.262110099531;7789.143194248628;7829.138794732575;7847.960760196277;2159.287435146398;2166.9783302167093;2168.2844661261747;2174.4563859035243;2340.7542208067907;915.839728047589;935.4013431403907;963.5904740485406;967.2020583018897;1010.3786171504472;19275.710864337045;20233.08951097204;20688.793112068986;20875.26936557213;21165.047572859257;1003.1673710820002;1015.751140970467;1024.7130803375067;1034.2811745836723;1035.1451691566529;9493.145616894513;10324.122449591869;10442;10676.306040107369;10735.731606709895;577092;673875;675305;685037;699304;116889;154397.68403473956;156594;161302.1934890318;163391;1029.248648486609;1198.748262864808;1229.5204870100667;1231.3658465890073;1232.1313474000988;17081.52409629517;21212.893935530225;21294.893525532272;22425.542339747863;22588.661170082134;62500.374996251274;62870.05694914672;62897;64184.35815641784;64451.35548644453;70365;90601;91616.54191728999;92274.53862730644;92314;7998.720044798404;8319.710444881053;8941.37410381267;8965.820683586422;9085.863712044456;13798.965077619017;13837.86162138406;13932.721345573234;13990.481713291705;14189.503367382093;10335.431551264752;10856.34861908288;11338.319700817978;11769.470373833026;11889.108316876442;11103.278286911325;11139.220254582102;11307.491162897853;11332.886671133183;11489.94255028753;11714.197179156505;11919.986801122002;12192.939035304767;12243.510259589517;12316.384180791103;8592.484450932963;8705.303575714055;8772.91227087721;8844.204021638083;8850.380473366802;9701.320907536405;11911.987481064207;12086.818697719717;12095.879041209828;12125.939370303446 03:43:29 INFO - PID 1930 | |3;mootools.html;1366.5148872150385;1409.9788503172447;1418.8510206428325;1424.750668632989;1447.8986470947034;11489.080873530118;11822.58620948267;11896.345700986441;11912.285262884234;12293.200941938767;11825.467853946571;11895.345755983417;11972;11982.340971246578;12006.69983250417;2483.590207615746;2545.3127655532994;2550.9668584223327;2557.6291437741515;2563.7564431379083;2465.6794616699804;2497.4880149569294;2528.254165021323;2540.6951165860123;2543.5548778963607;2448.6327050942414;2504.4239824840297;2529.595264757639;2533.64528965944;2535.366158460385;2395.544846479172;2462.7783499485045;2471.7281099079087;2472.8269021168526;2480.268320845355;2383.5709572276983;2443.486867757773;2448.179859746987;2489.4647650755173;2495.1017633651873;9580.329376943617;11941.402929853473;11963.46164422603;11967.521299148024;11988.940055299669;6627.37039981201;6877.2091209511045;6884.690188941459;6892.138482689664;6908.930910690879;4144.896377590554;4386.824527018915;4408.757518336491;4466.776661166961;4469.971906461532;1245.2030700351781;1269.2511418263268;1318.9010824188128;1322.1934619881865;1323.841139063309;15804.446844360507;16520.42178523746;16579.088150151736;16584.50246492607;16651.50045498637;5162.225666150108;5609.15862620602;5719.8570035749435;5861.238039054895;5868.94131058684;11561.248518846249;12258.325792081521;12291.56979505713;12323.75352492963;12360.25838449696;6606.372394622503;6662.86674266512;6668.333166683293;6673.866522669519;6676.9666151668935;6026.54800889935;6118.296395914438;6236.563440559117;6302.464290535356;6328.335524769833;3560.0209942266083;3804.923901521954;4393.582609652142;4453.242948698729;4489;1307.1506496082477;1324.4569726412126;1329.1360615599938;1333.7265860498574;1349.2511656030802;766.1878408886598;776.4758787818313;800.3037357499013;800.3677095094927;803.4094940218935;6604.3725846044545;6945.617991010442;6951.443884489228;7004.509684322151;7316.610033979569;768.723259626534;935.1303287942143;937.8499440089689;939.9671011514564;941.275218082073;4045.2516284487465;4167.666586673059;4236.173946080547;4274.636655884285;4334;13205.339733013503;15347.61630959235;15453.613659658598;15464.072155670696;15476;13599.456021759217;14335;15371.308291126927;15403.460878869186;15435.22823858825;9493.288003399635;10494.108000819862;10765.892341076646;10908.018278354986;11020.779584408267;5580.386157522588;6620.735170593122;6928.376446119873;7173.964130179315;7209.783706488814;12346.320952347347;12502.312372819582;12531.686707832378;12555.560555380518;12752.6811829705;12862.807057893951;12897.032722546035;13094.607161785161;13324.800127998282;13381.598552043455;8691.91308086911;8699.521526316114;8855;8888.86666700013;8918.910810891808;10601.25791194609;10602.522886470282;10714.089302409382;10730.678079657622;10744.355338679392;8966.372353935161;8999.460032398078;9072.183503484717;9181.357304988587;9208.815823683355;8743.256823169848;8869.068747781648;8930.374873758774;8941.508217048126;8948.328875334246;8070.838583228185;8098.595070246346;8114.310283625958;8120.106788253169;8177.9591102044105;6077.6961151943115;6103.816885493442;6174.783882564088;6202.4417802398;6213.347598502092;5197.688138711689;6073.453389194994;6195.070739389128;6238.438540531374;6258.718357673824 03:43:29 INFO - PID 1930 | |4;prototype.html;318.8501404339961;399.47070132075;399.77469057339255;400.19560683027106;401.59438966643717;5341.839744807652;5764.538836893049;5869.442402971717;5920.875033743586;6183.845403864906;5907.822765317037;6016.864013275279;6036.185115009473;6044.373375974413;6105.297890742566;3818.503594532721;4339.370791235269;4475.7762111894435;4599.609033232171;4609.723416595015;4629.120467111238;4646.697964632288;4646.697964632305;4653.302004699289;4671.743054132022;3898.8440462381614;4283.01490657149;4547.795349209294;4616.838410655628;4623.606993405565;3961.1879564689316;3993.940090898639;4550.180967425862;4563.817447302104;4638.837640682576;3985.561588225293;4081.8571350002903;4086.3257562502154;4106.117184805281;4108.465899433055;5527.226188333637;5802.564807639402;5946.197263369433;5972.9701351493395;5980.401959804029;4380.5838445347645;5194.558462530689;5265.815696450644;5273.499017593323;5285.207218917155;6102.3287438382185;6405.583637063576;6411.519136064814;6420.133282006916;6442;3620.71034317254;3718.4050551911564;4123.60825721559;4281.55043720408;4298.054428025829;6366.01326794343;6558.704858281389;6669.43309818666;6682.866342673168;6744.224414192382;4201.663866890642;4336.783160841946;4365.563443655673;4384.408104905797;4412.977935110304;4462.129884672458;4467.15124126415;4475.672650221932;4479.216137175981;4487.820487180476;4801.9039619208115;5001.349824522788;5242.554382877422;5244.370675518962;5263.315768950012;5326.680399176062;6472.546921715435;6502.804915852532;6514.478841692653;6566.277709451956;1163.4764356039816;1328.6014195741238;1364.3178410794603;1523.54293711886;1550.046721266413;947.843630770459;958.6841208817974;1014.2849291249652;1016.2428990402198;1031.3554028732042;5629.915551266734;5818.010938140526;6068.241469816273;6131.816045518642;6140.508759299245;6000.459958603747;6413.486921046305;6631.933680663228;6721.899171512431;6739.865202695919;5882.676452795137;5995.790147344822;6009.519238460913;6055.455009049207;6109.572329936862;3328.0182346207926;3337.8831740888954;3509.701675357623;3519.2609551993855;3521.559805024372;6534.248561415498;6803.625800581016;6834.794956151323;6898.965505172442;6911.89632155518;5916.704164791743;6865.391151362451;6870.896936545956;6898.37888096297;6903.792886213321;6474.5791523550815;6698.956818170504;6715.664216789141;6890.793276201722;6914.308569143045;5296.364436267672;6657.470161338661;6670.232923213893;6709.7651582194385;6729.596224226562;5509.614326997232;5612.214289999321;6298.433141017331;6333.701591173891;6604.075429439787;6781.220159681502;6883.449324054164;6914.0666010088;6919.446444284546;6967.477439192182;4402.911941761083;4437.179121862466;4441.888952776207;4444.000199910118;4450.532694067206;6497.740090396331;6561.40947314744;6619.968823693931;6676;6735.966320168368;5851;6459.869522833579;6474.482041436768;6482.189726284215;6547.083408322934;5346.251524786455;5910.911336329872;6222.408871157233;6377.298497165215;6434.613923164625;6260.154879091265;6275.309715931336;6310.3715363667;6318.27339855904;6330.303666596763;5388.595855310946;6240.906386404116;6435.581687190318;6461.483081353386;6500.5449618526245;5676.262085928803;6172.845678858064;6295.874082518416;6327.3988971047675;6330.0504924259885 03:43:29 INFO - PID 1930 | |5;yui.html;833.7582101190656;853.9402241843071;855.8630619100945;869.0787764969132;870.2168048756118;15443.768343474856;16552.75170872438;16630.83369166308;16953.915230423845;17054.97670139791;17971;18086.63826723468;18266.81733182671;18318.35885743999;18368.80602760823;984.8965858584853;1009.1271050541266;1011.292095533126;1012;1017.7557386227326;986.5363279258737;1002.3785253143061;1005.4671024357102;1009.7425156585098;1011.6307547745093;1069.6202847988968;1072.3244356055714;1076.1444651502036;1078.0728573426848;1078.8597482327286;1051.7055224537103;1057.4501259345097;1072.7532667486482;1072.8390741388775;1074.08702602787;745.9365953893926;762.2111114996007;789.6643926331286;792.0376742258127;794.6225542867091;16583.50249492517;16597.087160206185;16766.497005089866;16772.07753573553;16786.992780433215;16578;16941.83058169415;17058.23237954295;17264.999999999873;17292.740608890876;13635;13635.113717608423;13974.650633734136;13976.440942362293;13989.720205595831;3457;3527.629598892105;3538.0800991742076;3539.6991255743037;3546.184377593168;97511.0248897509;116115;121622.39188804087;122414.38792805979;123646;13365.997550183774;13607.31963401826;13672.658183545293;13675.931620342033;13709.108907921152;24325.391865203157;25130.497390052464;25275.24174274775;25740.97036118572;25798.87100564485;9013.278937684969;9097.13577210164;9140.314476414296;9151.725448236564;9163.770905727277;4649.18639238132;4780.928286075712;4874.707517548958;4878.512148785164;4884.633652476007;4321.935170972438;4461.2415889298245;4468.218061839165;4479.46246450428;4482.887927801831;816.979575510617;942.3074040580168;981.3670182732097;986.3145114145743;988.7182153086336;642.8039447968321;645.8966565349522;646.7865604350553;651.4885814635583;674.8076798112514;11063;11805.631916190892;12055;12170.208936419105;12223.572174973833;656.2223764838682;660.8215781738903;662.4766434516678;674.3660958698807;687.2097088348339;5480.558727752322;5553.6390134641115;5688.886222275614;5793.362730099686;5810.6513609183585;84907;84947;85867;87646;106479.40280895792;74986.25013749793;76849;79079.60460197777;79673;80866.59566702247;72325.2767472329;73035;73187.53624927578;74005.819592628;75717.62141189259;11603.419829008684;12005.219660722025;12110.091743119125;12194.451249693608;12292.754144917231;39261.8036909825;39389.212215756095;39992.80003599964;40778;41011.97470063272;61176.32942023493;62795.058074128014;69528;70694;72173.27826721665;16138.354465821236;16392.836071639133;16431.671366572842;16471.176441177653;16475.258613362188;17017.574560636083;17088.316467341167;17415.912920435825;17540.561485962444;17591.384301549384;13144.868551314365;16461.58846028859;16494.505164845075;16836.915815420845;16856;16612.335506579602;16650.574610201318;16698.08160551133;16816.159192040104;16919.577010574834;13372.665683357995;16255.837441625432;16387.59031024234;16540.255688494286;16611.169441527632;9199.298129846;11774.411279436164;12134.757304853676;12135.211211271593;12477.93761031189;12913.806292905427;13183.53857614979;13541.05212635106;13582.59252222435;13791.655208619464 03:43:29 INFO - PID 1930 | __end_tp_report 03:43:29 INFO - PID 1930 | __start_cc_report 03:43:29 INFO - PID 1930 | _x_x_mozilla_cycle_collect,419 03:43:29 INFO - PID 1930 | __end_cc_report 03:43:29 INFO - PID 1930 | __startTimestamp1491821009665__endTimestamp 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | ------- Summary: start ------- 03:43:29 INFO - PID 1930 | Number of tests: 6 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | [#0] dojo.html Cycles:165 Average:6084.94 Median:6335.49 stddev:720.36 (11.4%) stddev-sans-first:690.47 03:43:29 INFO - PID 1930 | Values: 3374.6 3398.1 3534.3 3554.1 3575.3 6027.8 6179.4 6194.1 6210.9 6247.8 6082.8 6105.6 6136.5 6140.8 6187.8 5424.9 5436.1 5506.1 5507.9 5567.8 5370.4 5517.9 5518.9 5532.8 5542.1 5435.8 5489.0 5535.3 5538.6 5546.3 4620.5 5327.6 5373.8 5466.7 5495.6 5289.5 5319.8 5329.4 5377.8 5398.3 5145.0 6198.1 6210.0 6216.8 6260.4 6614.8 6668.2 6681.2 6689.5 6705.2 6388.1 6476.7 6572.9 6789.6 6795.6 6297.5 6310.7 6335.3 6359.3 6360.1 6756.1 6886.0 6908.2 6914.6 6922.0 6279.0 6338.1 6485.1 6528.9 6541.7 6538.2 6631.5 6646.9 6673.9 6686.6 5426.4 6545.1 6570.2 6573.8 6583.7 6312.4 6361.4 6498.5 6547.4 6582.2 5305.4 5323.3 5324.9 5327.5 5391.3 4656.3 4658.8 4662.3 4673.0 4699.8 6186.5 6357.3 6376.6 6383.5 6393.6 6442.2 6614.1 6686.0 6720.4 6743.2 6311.8 6335.5 6338.3 6346.4 6360.9 5854.2 5862.1 5876.4 5891.0 5903.7 5264.6 6501.1 6564.6 6795.5 6832.1 6762.4 6765.1 6769.8 6784.7 6794.0 5503.6 6605.5 6702.0 6904.3 6920.8 6406.2 6502.0 6502.1 6531.3 6540.7 5585.5 6586.7 6662.2 6667.7 6689.9 5481.4 6276.7 6376.6 6410.1 6412.5 6252.2 6410.6 6462.5 6487.3 6494.5 6290.1 6304.4 6327.1 6405.5 6413.8 6387.9 6518.9 6544.9 6549.6 6553.7 6192.7 6247.5 6260.3 6281.2 6289.7 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | [#1] ext.html Cycles:180 Average:46436.25 Median:33401.83 stddev:84176.55 (252.0%) stddev-sans-first:84342.73 03:43:29 INFO - PID 1930 | Values: 728.3 796.4 823.7 1273.8 1277.6 23045.8 32142.8 32159.7 32240.7 32246.0 38535.8 38794.4 38813.6 38869.8 38871.8 7997.7 8127.5 8411.7 8686.7 8713.6 8688.2 8770.9 8783.5 8789.7 8807.4 8713.3 8796.0 8800.3 8811.8 8829.8 8751.1 8776.0 8777.8 8786.3 8800.6 8541.8 8614.7 8616.6 8625.0 8636.1 37885.8 38032.6 38072.4 38150.4 38193.0 3618.6 3640.3 3651.1 3663.4 3664.5 31158.0 31197.7 31215.8 31235.8 31266.4 3157.2 3185.0 3191.8 3196.3 3199.2 229939.0 234730.0 261737.0 285413.0 286948.6 47064.8 47353.0 47383.3 47405.5 47541.0 49404.5 49676.3 49748.3 49834.8 49979.0 14130.6 14204.0 14204.6 14240.1 14261.5 11703.4 11705.5 11729.0 11745.7 11762.7 13599.5 13670.5 13671.1 13699.5 13761.7 5065.9 5445.5 5858.6 6094.3 6130.9 909.9 979.1 1024.8 1030.5 1036.2 22679.5 23916.9 24517.1 24643.5 24644.5 1004.8 1152.6 1153.3 1153.4 1158.1 12612.1 12615.2 12629.7 12664.2 12742.2 370564.0 372749.0 373850.1 374613.0 374637.0 53664.5 53702.7 53736.0 53749.0 53821.0 1492.0 1513.8 1553.4 1557.0 1560.4 23963.3 24070.8 24197.6 24207.8 24624.5 38116.0 38390.8 38433.2 38449.4 38487.6 312515.0 313873.0 316254.0 316955.0 317573.8 27595.9 34423.7 35210.8 35335.6 35705.6 45346.3 46311.0 46383.8 46392.8 46428.1 30217.8 30439.8 30762.2 31483.6 31898.8 30529.4 31379.7 31457.0 31491.2 31740.7 37458.0 37478.3 37595.2 37595.8 37620.2 30128.8 30747.7 31287.4 32096.7 32380.0 18808.2 24446.4 24690.1 24886.6 24936.8 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | [#2] jquery.html Cycles:180 Average:39494.29 Median:22629.83 stddev:111516.11 (492.8%) stddev-sans-first:111790.30 03:43:29 INFO - PID 1930 | Values: 394.9 422.9 424.8 430.8 446.3 20007.9 21641.6 22215.3 22396.4 22539.7 22090.0 22671.0 22880.9 22944.2 23441.8 4941.9 5030.1 6199.4 6409.4 6432.2 5660.6 5973.2 6246.6 6393.6 6430.3 6141.4 6370.9 6384.4 6407.9 6425.5 5382.2 6221.7 6357.5 6369.8 6371.6 5394.2 5566.7 5626.2 5633.0 5639.7 26113.2 26498.5 26499.9 26777.3 26964.1 2009.8 2203.5 2272.5 2285.7 2287.1 15555.3 17678.3 17689.3 17787.9 18234.5 2150.9 2190.1 2223.4 2229.6 2233.9 145373.0 145885.3 145947.0 146076.0 153299.7 10083.3 11777.2 12254.4 12256.8 12683.6 16157.4 16241.1 16247.4 16253.1 16298.0 8746.3 8968.4 9017.4 9027.7 9126.5 6919.2 8483.2 8502.4 8632.0 8637.0 7695.7 7767.3 7789.1 7829.1 7848.0 2159.3 2167.0 2168.3 2174.5 2340.8 915.8 935.4 963.6 967.2 1010.4 19275.7 20233.1 20688.8 20875.3 21165.0 1003.2 1015.8 1024.7 1034.3 1035.1 9493.1 10324.1 10442.0 10676.3 10735.7 577092.0 673875.0 675305.0 685037.0 699304.0 116889.0 154397.7 156594.0 161302.2 163391.0 1029.2 1198.7 1229.5 1231.4 1232.1 17081.5 21212.9 21294.9 22425.5 22588.7 62500.4 62870.1 62897.0 64184.4 64451.4 70365.0 90601.0 91616.5 92274.5 92314.0 7998.7 8319.7 8941.4 8965.8 9085.9 13799.0 13837.9 13932.7 13990.5 14189.5 10335.4 10856.3 11338.3 11769.5 11889.1 11103.3 11139.2 11307.5 11332.9 11489.9 11714.2 11920.0 12192.9 12243.5 12316.4 8592.5 8705.3 8772.9 8844.2 8850.4 9701.3 11912.0 12086.8 12095.9 12125.9 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | [#3] mootools.html Cycles:180 Average:7154.64 Median:2554.30 stddev:4480.80 (175.4%) stddev-sans-first:4472.26 03:43:29 INFO - PID 1930 | Values: 1366.5 1410.0 1418.9 1424.8 1447.9 11489.1 11822.6 11896.3 11912.3 12293.2 11825.5 11895.3 11972.0 11982.3 12006.7 2483.6 2545.3 2551.0 2557.6 2563.8 2465.7 2497.5 2528.3 2540.7 2543.6 2448.6 2504.4 2529.6 2533.6 2535.4 2395.5 2462.8 2471.7 2472.8 2480.3 2383.6 2443.5 2448.2 2489.5 2495.1 9580.3 11941.4 11963.5 11967.5 11988.9 6627.4 6877.2 6884.7 6892.1 6908.9 4144.9 4386.8 4408.8 4466.8 4470.0 1245.2 1269.3 1318.9 1322.2 1323.8 15804.4 16520.4 16579.1 16584.5 16651.5 5162.2 5609.2 5719.9 5861.2 5868.9 11561.2 12258.3 12291.6 12323.8 12360.3 6606.4 6662.9 6668.3 6673.9 6677.0 6026.5 6118.3 6236.6 6302.5 6328.3 3560.0 3804.9 4393.6 4453.2 4489.0 1307.2 1324.5 1329.1 1333.7 1349.3 766.2 776.5 800.3 800.4 803.4 6604.4 6945.6 6951.4 7004.5 7316.6 768.7 935.1 937.8 940.0 941.3 4045.3 4167.7 4236.2 4274.6 4334.0 13205.3 15347.6 15453.6 15464.1 15476.0 13599.5 14335.0 15371.3 15403.5 15435.2 9493.3 10494.1 10765.9 10908.0 11020.8 5580.4 6620.7 6928.4 7174.0 7209.8 12346.3 12502.3 12531.7 12555.6 12752.7 12862.8 12897.0 13094.6 13324.8 13381.6 8691.9 8699.5 8855.0 8888.9 8918.9 10601.3 10602.5 10714.1 10730.7 10744.4 8966.4 8999.5 9072.2 9181.4 9208.8 8743.3 8869.1 8930.4 8941.5 8948.3 8070.8 8098.6 8114.3 8120.1 8178.0 6077.7 6103.8 6174.8 6202.4 6213.3 5197.7 6073.5 6195.1 6238.4 6258.7 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | [#4] prototype.html Cycles:180 Average:5227.30 Median:5913.81 stddev:1637.26 (27.7%) stddev-sans-first:1599.86 03:43:29 INFO - PID 1930 | Values: 318.9 399.5 399.8 400.2 401.6 5341.8 5764.5 5869.4 5920.9 6183.8 5907.8 6016.9 6036.2 6044.4 6105.3 3818.5 4339.4 4475.8 4599.6 4609.7 4629.1 4646.7 4646.7 4653.3 4671.7 3898.8 4283.0 4547.8 4616.8 4623.6 3961.2 3993.9 4550.2 4563.8 4638.8 3985.6 4081.9 4086.3 4106.1 4108.5 5527.2 5802.6 5946.2 5973.0 5980.4 4380.6 5194.6 5265.8 5273.5 5285.2 6102.3 6405.6 6411.5 6420.1 6442.0 3620.7 3718.4 4123.6 4281.6 4298.1 6366.0 6558.7 6669.4 6682.9 6744.2 4201.7 4336.8 4365.6 4384.4 4413.0 4462.1 4467.2 4475.7 4479.2 4487.8 4801.9 5001.3 5242.6 5244.4 5263.3 5326.7 6472.5 6502.8 6514.5 6566.3 1163.5 1328.6 1364.3 1523.5 1550.0 947.8 958.7 1014.3 1016.2 1031.4 5629.9 5818.0 6068.2 6131.8 6140.5 6000.5 6413.5 6631.9 6721.9 6739.9 5882.7 5995.8 6009.5 6055.5 6109.6 3328.0 3337.9 3509.7 3519.3 3521.6 6534.2 6803.6 6834.8 6899.0 6911.9 5916.7 6865.4 6870.9 6898.4 6903.8 6474.6 6699.0 6715.7 6890.8 6914.3 5296.4 6657.5 6670.2 6709.8 6729.6 5509.6 5612.2 6298.4 6333.7 6604.1 6781.2 6883.4 6914.1 6919.4 6967.5 4402.9 4437.2 4441.9 4444.0 4450.5 6497.7 6561.4 6620.0 6676.0 6736.0 5851.0 6459.9 6474.5 6482.2 6547.1 5346.3 5910.9 6222.4 6377.3 6434.6 6260.2 6275.3 6310.4 6318.3 6330.3 5388.6 6240.9 6435.6 6461.5 6500.5 5676.3 6172.8 6295.9 6327.4 6330.1 03:43:29 INFO - PID 1930 | 03:43:29 INFO - PID 1930 | [#5] yui.html Cycles:180 Average:20927.71 Median:17565.97 stddev:27989.34 (159.3%) stddev-sans-first:28027.19 03:43:29 INFO - PID 1930 | Values: 833.8 853.9 855.9 869.1 870.2 15443.8 16552.8 16630.8 16953.9 17055.0 17971.0 18086.6 18266.8 18318.4 18368.8 984.9 1009.1 1011.3 1012.0 1017.8 986.5 1002.4 1005.5 1009.7 1011.6 1069.6 1072.3 1076.1 1078.1 1078.9 1051.7 1057.5 1072.8 1072.8 1074.1 745.9 762.2 789.7 792.0 794.6 16583.5 16597.1 16766.5 16772.1 16787.0 16578.0 16941.8 17058.2 17265.0 17292.7 13635.0 13635.1 13974.7 13976.4 13989.7 3457.0 3527.6 3538.1 3539.7 3546.2 97511.0 116115.0 121622.4 122414.4 123646.0 13366.0 13607.3 13672.7 13675.9 13709.1 24325.4 25130.5 25275.2 25741.0 25798.9 9013.3 9097.1 9140.3 9151.7 9163.8 4649.2 4780.9 4874.7 4878.5 4884.6 4321.9 4461.2 4468.2 4479.5 4482.9 817.0 942.3 981.4 986.3 988.7 642.8 645.9 646.8 651.5 674.8 11063.0 11805.6 12055.0 12170.2 12223.6 656.2 660.8 662.5 674.4 687.2 5480.6 5553.6 5688.9 5793.4 5810.7 84907.0 84947.0 85867.0 87646.0 106479.4 74986.3 76849.0 79079.6 79673.0 80866.6 72325.3 73035.0 73187.5 74005.8 75717.6 11603.4 12005.2 12110.1 12194.5 12292.8 39261.8 39389.2 39992.8 40778.0 41012.0 61176.3 62795.1 69528.0 70694.0 72173.3 16138.4 16392.8 16431.7 16471.2 16475.3 17017.6 17088.3 17415.9 17540.6 17591.4 13144.9 16461.6 16494.5 16836.9 16856.0 16612.3 16650.6 16698.1 16816.2 16919.6 13372.7 16255.8 16387.6 16540.3 16611.2 9199.3 11774.4 12134.8 12135.2 12477.9 12913.8 13183.5 13541.1 13582.6 13791.7 03:43:29 INFO - PID 1930 | -------- Summary: end -------- 03:43:29 INFO - PID 1930 | 03:43:30 INFO - TEST-INFO | 1930: exit 0 03:43:30 INFO - TEST-OK | dromaeo_css | took 1115592ms 03:43:30 INFO - TEST-START | kraken 03:43:30 INFO - operating with platform_type : mac_ 03:43:30 INFO - Initialising browser for kraken test... 03:43:30 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpmbC2TM/profile http://localhost:53440/getInfo.html) 03:43:33 INFO - PID 1959 | 2017-04-10 03:43:33.192 plugin-container[1960:18903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 03:43:33 INFO - PID 1959 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:33 INFO - PID 1959 | 2017-04-10 03:43:33.195 plugin-container[1960:18903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 03:43:33 INFO - PID 1959 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:33 INFO - PID 1959 | 2017-04-10 03:43:33.195 plugin-container[1960:18903] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:43:33 INFO - PID 1959 | __metrics Screen width/height:1600/1200 03:43:33 INFO - PID 1959 | colorDepth:24 03:43:33 INFO - PID 1959 | Browser inner width/height: 1024/689 03:43:33 INFO - PID 1959 | __metrics 03:43:33 ERROR - PID 1959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 03:43:34 INFO - TEST-INFO | 1959: exit 0 03:43:34 INFO - Browser initialized. 03:43:34 INFO - Running cycle 1/1 for kraken test... 03:43:34 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpmbC2TM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:36 INFO - PID 1961 | 2017-04-10 03:43:36.818 plugin-container[1962:19035] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4f, name = 'com.apple.tsm.portname' 03:43:36 INFO - PID 1961 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:36 INFO - PID 1961 | 2017-04-10 03:43:36.819 plugin-container[1962:19035] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:43:36 INFO - PID 1961 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:43:36 INFO - PID 1961 | 2017-04-10 03:43:36.819 plugin-container[1962:19035] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:43:46 INFO - PID 1961 | RSS: Main: 234061824 03:43:46 INFO - PID 1961 | 03:43:49 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53440/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:50 INFO - PID 1961 | RSS: Main: 249040896 03:43:50 INFO - PID 1961 | 03:43:53 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53440/tests/kraken/driver.html?testName=audio-dft) 03:43:53 INFO - PID 1961 | RSS: Main: 257597440 03:43:53 INFO - PID 1961 | 03:43:57 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53440/tests/kraken/driver.html?testName=audio-fft) 03:43:57 INFO - PID 1961 | RSS: Main: 259809280 03:43:57 INFO - PID 1961 | 03:44:00 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53440/tests/kraken/driver.html?testName=audio-oscillator) 03:44:00 INFO - PID 1961 | RSS: Main: 260890624 03:44:00 INFO - PID 1961 | 03:44:02 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:03 INFO - PID 1961 | RSS: Main: 261320704 03:44:03 INFO - PID 1961 | 03:44:06 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53440/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:07 INFO - PID 1961 | RSS: Main: 266915840 03:44:07 INFO - PID 1961 | 03:44:10 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53440/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:11 INFO - PID 1961 | RSS: Main: 264785920 03:44:11 INFO - PID 1961 | 03:44:14 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53440/tests/kraken/driver.html?testName=json-parse-financial) 03:44:15 INFO - PID 1961 | RSS: Main: 267091968 03:44:15 INFO - PID 1961 | 03:44:16 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:17 INFO - PID 1961 | RSS: Main: 267567104 03:44:17 INFO - PID 1961 | 03:44:19 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:19 INFO - PID 1961 | RSS: Main: 267210752 03:44:19 INFO - PID 1961 | 03:44:22 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:23 INFO - PID 1961 | RSS: Main: 267317248 03:44:23 INFO - PID 1961 | 03:44:26 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:26 INFO - PID 1961 | RSS: Main: 267845632 03:44:26 INFO - PID 1961 | 03:44:30 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:44:30 INFO - PID 1961 | RSS: Main: 265777152 03:44:30 INFO - PID 1961 | 03:44:32 INFO - PID 1961 | Cycle 1(1): loaded http://localhost:53440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53440/tests/kraken/driver.html?testName=ai-astar) 03:44:33 INFO - PID 1961 | RSS: Main: 269156352 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | __start_tp_report 03:44:33 INFO - PID 1961 | _x_x_mozilla_page_load 03:44:33 INFO - PID 1961 | _x_x_mozilla_page_load_details 03:44:33 INFO - PID 1961 | |i|pagename|runs| 03:44:33 INFO - PID 1961 | |0;ai-astar;97;178;161;122;123;124;121;121;119;130 03:44:33 INFO - PID 1961 | |1;audio-beat-detection;152;116;120;167;115;116;148;152;178;120 03:44:33 INFO - PID 1961 | |2;audio-dft;219;229;225;225;235;219;213;221;208;218 03:44:33 INFO - PID 1961 | |3;audio-fft;77;59;61;88;63;77;50;65;107;92 03:44:33 INFO - PID 1961 | |4;audio-oscillator;94;72;87;73;72;74;88;74;100;84 03:44:33 INFO - PID 1961 | |5;imaging-gaussian-blur;92;92;90;93;141;143;94;92;95;131 03:44:33 INFO - PID 1961 | |6;imaging-darkroom;101;110;114;155;148;163;117;104;164;100 03:44:33 INFO - PID 1961 | |7;imaging-desaturate;154;116;108;165;135;102;103;109;103;103 03:44:33 INFO - PID 1961 | |8;json-parse-financial;52;51;51;51;53;53;52;52;52;52 03:44:33 INFO - PID 1961 | |9;json-stringify-tinderbox;61;65;62;75;68;76;90;91;61;61 03:44:33 INFO - PID 1961 | |10;stanford-crypto-aes;89;94;117;114;77;106;84;112;114;115 03:44:33 INFO - PID 1961 | |11;stanford-crypto-ccm;164;147;171;170;179;154;151;149;195;188 03:44:33 INFO - PID 1961 | |12;stanford-crypto-pbkdf2;206;209;262;206;199;203;229;256;218;198 03:44:33 INFO - PID 1961 | |13;stanford-crypto-sha256-iterative;70;73;75;86;72;72;72;74;72;97 03:44:33 INFO - PID 1961 | __end_tp_report 03:44:33 INFO - PID 1961 | __start_cc_report 03:44:33 INFO - PID 1961 | _x_x_mozilla_cycle_collect,1012 03:44:33 INFO - PID 1961 | __end_cc_report 03:44:33 INFO - PID 1961 | __startTimestamp1491821073049__endTimestamp 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | ------- Summary: start ------- 03:44:33 INFO - PID 1961 | Number of tests: 14 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#0] ai-astar Cycles:10 Average:129.60 Median:127.00 stddev:23.06 (18.2%) stddev-sans-first:21.22 03:44:33 INFO - PID 1961 | Values: 97.0 178.0 161.0 122.0 123.0 124.0 121.0 121.0 119.0 130.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:150.00 stddev:23.75 (15.8%) stddev-sans-first:24.68 03:44:33 INFO - PID 1961 | Values: 152.0 116.0 120.0 167.0 115.0 116.0 148.0 152.0 178.0 120.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#2] audio-dft Cycles:10 Average:221.20 Median:223.00 stddev:7.76 (3.5%) stddev-sans-first:8.19 03:44:33 INFO - PID 1961 | Values: 219.0 229.0 225.0 225.0 235.0 219.0 213.0 221.0 208.0 218.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#3] audio-fft Cycles:10 Average:73.90 Median:71.00 stddev:17.63 (24.8%) stddev-sans-first:18.67 03:44:33 INFO - PID 1961 | Values: 77.0 59.0 61.0 88.0 63.0 77.0 50.0 65.0 107.0 92.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:79.00 stddev:10.23 (12.9%) stddev-sans-first:9.85 03:44:33 INFO - PID 1961 | Values: 94.0 72.0 87.0 73.0 72.0 74.0 88.0 74.0 100.0 84.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#5] imaging-gaussian-blur Cycles:10 Average:106.30 Median:92.00 stddev:22.35 (24.3%) stddev-sans-first:23.10 03:44:33 INFO - PID 1961 | Values: 92.0 92.0 90.0 93.0 141.0 143.0 94.0 92.0 95.0 131.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#6] imaging-darkroom Cycles:10 Average:127.60 Median:132.50 stddev:26.62 (20.1%) stddev-sans-first:26.44 03:44:33 INFO - PID 1961 | Values: 101.0 110.0 114.0 155.0 148.0 163.0 117.0 104.0 164.0 100.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#7] imaging-desaturate Cycles:10 Average:119.80 Median:112.50 stddev:23.28 (20.7%) stddev-sans-first:21.15 03:44:33 INFO - PID 1961 | Values: 154.0 116.0 108.0 165.0 135.0 102.0 103.0 109.0 103.0 103.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 03:44:33 INFO - PID 1961 | Values: 52.0 51.0 51.0 51.0 53.0 53.0 52.0 52.0 52.0 52.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:11.68 (16.3%) stddev-sans-first:11.82 03:44:33 INFO - PID 1961 | Values: 61.0 65.0 62.0 75.0 68.0 76.0 90.0 91.0 61.0 61.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#10] stanford-crypto-aes Cycles:10 Average:102.20 Median:97.00 stddev:14.83 (15.3%) stddev-sans-first:14.94 03:44:33 INFO - PID 1961 | Values: 89.0 94.0 117.0 114.0 77.0 106.0 84.0 112.0 114.0 115.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#11] stanford-crypto-ccm Cycles:10 Average:166.80 Median:170.50 stddev:16.84 (9.9%) stddev-sans-first:17.83 03:44:33 INFO - PID 1961 | Values: 164.0 147.0 171.0 170.0 179.0 154.0 151.0 149.0 195.0 188.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.60 Median:213.50 stddev:23.22 (10.9%) stddev-sans-first:24.18 03:44:33 INFO - PID 1961 | Values: 206.0 209.0 262.0 206.0 199.0 203.0 229.0 256.0 218.0 198.0 03:44:33 INFO - PID 1961 | 03:44:33 INFO - PID 1961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:73.50 stddev:8.53 (11.6%) stddev-sans-first:8.73 03:44:33 INFO - PID 1961 | Values: 70.0 73.0 75.0 86.0 72.0 72.0 72.0 74.0 72.0 97.0 03:44:33 INFO - PID 1961 | -------- Summary: end -------- 03:44:33 INFO - PID 1961 | 03:44:34 INFO - TEST-INFO | 1961: exit 0 03:44:34 INFO - TEST-OK | kraken | took 63815ms 03:44:34 INFO - SUITE-END | took 1179s 03:44:34 INFO - Completed test suite (00:19:39) 03:44:34 INFO - javascript benchmark 03:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7897.105518780657, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.5613070300856, 3398.082517720215, 3534.2754735279254, 3554.147004718868, 3575.2849430113965, 6027.849303767408, 6179.351168127349, 6194.132821405001, 6210.906836397452, 6247.7813276535335, 6082.756689732405, 6105.633661980273, 6136.539759518043, 6140.754369825213, 6187.783427580036, 5424.945750542503, 5436.103042997901, 5506.091494903336, 5507.889842203173, 5567.832965011036, 5370.355557333126, 5517.917231241535, 5518.944810551903, 5532.834014979537, 5542.1132618781, 5435.782568697267, 5488.9725551372185, 5535.308086489189, 5538.6399884007415, 5546.306711661043, 4620.53794620537, 5327.600429967768, 5373.7581808818695, 5466.726663666801, 5495.560355171617, 5289.523942845162, 5319.840404787863, 5329.360476742816, 5377.784888604451, 5398.2712333834825, 5145.0, 6198.101275315099, 6210.0, 6216.844578885519, 6260.405261500196, 6614.7684831031165, 6668.199816022108, 6681.198256209237, 6689.531732778707, 6705.195376554844, 6388.137601423795, 6476.676166191672, 6572.86854262912, 6789.558678685919, 6795.592264464148, 6297.527685423565, 6310.652914089677, 6335.303116657164, 6359.332270111664, 6360.077788720656, 6756.121704178524, 6886.0, 6908.205556361083, 6914.619695916672, 6922.03091567181, 6278.968605156945, 6338.080978258126, 6485.1245081914285, 6528.934710652928, 6541.738330466728, 6538.248101468392, 6631.535792494576, 6646.86706265872, 6673.933260667428, 6686.598804071771, 5426.375966763794, 6545.083688283644, 6570.211574611078, 6573.769918052941, 6583.670816459158, 6312.368763123743, 6361.395667411589, 6498.5126115541525, 6547.410733034049, 6582.210134783761, 5305.44292849253, 5323.30796996388, 5324.866878327995, 5327.520523152857, 5391.29913111293, 4656.301554766812, 4658.813647454132, 4662.323963025342, 4673.0, 4699.835505757282, 6186.536009799283, 6357.332480089524, 6376.617402955838, 6383.521235907326, 6393.584417012879, 6442.162518872517, 6614.140161779034, 6685.966570167118, 6720.361565651256, 6743.224529179109, 6311.842203944938, 6335.493160547145, 6338.334474880164, 6346.397092276226, 6360.9045864312075, 5854.238948936696, 5862.091375836752, 5876.44173803488, 5890.970545147246, 5903.734331955073, 5264.605154613343, 6501.0573466847045, 6564.606123632598, 6795.456363491007, 6832.111825462658, 6762.391384775394, 6765.086713293643, 6769.830754231184, 6784.6946887389195, 6793.966030170015, 5503.587230957614, 6605.471562275103, 6701.966490167518, 6904.27505111956, 6920.826979325557, 6406.23125224976, 6501.9674901625185, 6502.057201705821, 6531.314212007671, 6540.705668244846, 5585.525230355465, 6586.715590459814, 6662.233843108104, 6667.66661666905, 6689.933100668931, 5481.369642491165, 6276.6547839869245, 6376.585521941244, 6410.134631824644, 6412.454941329853, 6252.218472690914, 6410.647414392253, 6462.5153113515735, 6487.318831522811, 6494.4804415645685, 6290.0879372491645, 6304.401081897213, 6327.050942358683, 6405.487560995202, 6413.839654008687, 6387.914054610635, 6518.869622607426, 6544.901826472512, 6549.574277671936, 6553.737850485927, 6192.690365481798, 6247.468965138014, 6260.311365749855, 6281.246250449975, 6289.654069026247], "value": 6038.424345344321, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.3262981741888, 796.4186144114796, 823.7240524424316, 1273.8280332155161, 1277.584784944893, 23045.76954230459, 32142.839285803566, 32159.67840321596, 32240.67759322406, 32246.0, 38535.80732096336, 38794.418083728764, 38813.61186388135, 38869.80565097178, 38871.805640971754, 7997.680092796281, 8127.512349259034, 8411.747647570583, 8686.739397818075, 8713.607887645072, 8688.218060374566, 8770.912290877106, 8783.472991620523, 8789.736307910742, 8807.427517211361, 8713.259372953275, 8796.0, 8800.295976321879, 8811.77970550738, 8829.779255518599, 8751.081136480641, 8775.956120219422, 8777.780555486132, 8786.29709623235, 8800.559972001407, 8541.786455338604, 8614.698485552975, 8616.569171541461, 8625.008124065687, 8636.0932102129, 37885.810570947244, 38032.61967380346, 38072.42891356632, 38150.42774358387, 38193.045173870596, 3618.583862855779, 3640.271945610862, 3651.087228192952, 3663.358912190383, 3664.5236119304586, 31158.0, 31197.688023119706, 31215.84392078025, 31235.843820780978, 31266.43667816623, 3157.226479512511, 3185.0285662872816, 3191.776575639706, 3196.3127927495466, 3199.2161920329436, 229939.0, 234730.0, 261737.0, 285413.0, 286948.5652571745, 47064.76467617709, 47353.0, 47383.314002319945, 47405.5259447408, 47541.04917901692, 49404.50595493999, 49676.254856177184, 49748.253776193385, 49834.75082624636, 49979.0, 14130.576082717535, 14204.005719599736, 14204.644883877985, 14240.074395164489, 14261.504236758527, 11703.356315402734, 11705.531778728755, 11729.0, 11745.706357340963, 11762.70593235176, 13599.456021759019, 13670.52153174634, 13671.086047953295, 13699.45202191921, 13761.724765504634, 5065.873353166126, 5445.53712934405, 5858.5898987070495, 6094.329623741385, 6130.938690613126, 909.9181073703398, 979.1285755677453, 1024.800163968019, 1030.5156576409076, 1036.2435422141727, 22679.546409071725, 23916.88041559781, 24517.141900033414, 24643.507129857302, 24644.507109857703, 1004.8392257238806, 1152.5505053029326, 1153.256781229482, 1153.3887039868882, 1158.0966845860241, 12612.117151799286, 12615.18001329929, 12629.684257893443, 12664.176828506303, 12742.171758835646, 370564.0, 372749.0, 373850.13074934995, 374613.0, 374637.0, 53664.46335536673, 53702.65743356448, 53736.0, 53749.0, 53821.0, 1491.970160596782, 1513.8259100203397, 1553.3631211203353, 1556.9532914012598, 1560.4070453227928, 23963.28110156698, 24070.759292406852, 24197.63703544413, 24207.789610519754, 24624.50750985006, 38116.04709882275, 38390.808045959595, 38433.2313353737, 38449.42325865058, 38487.6151238484, 312515.0, 313873.0, 316254.0, 316955.0, 317573.76983610925, 27595.86202068977, 34423.655763442046, 35210.8239458801, 35335.64664353323, 35705.64294357127, 45346.319805202285, 46311.0, 46383.76808115938, 46392.76803616095, 46428.071438571715, 30217.848910755307, 30439.847800760854, 30762.230944226572, 31483.583238753854, 31898.84050579732, 30529.38941221119, 31379.686203137677, 31457.0, 31491.212719682193, 31740.682593173773, 37458.0, 37478.252174782305, 37595.24809503849, 37595.81202093972, 37620.247595047396, 30128.849355753082, 30747.692523074482, 31287.374252514368, 32096.67903320937, 32380.0, 18808.24767009359, 24446.388840279134, 24690.13584524533, 24886.626700599143, 24936.750632494168], "value": 17673.555363931384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8716667083197, 422.8837069805805, 424.75576543487483, 430.75877508595187, 446.2502994968454, 20007.89956552389, 21641.56716865664, 22215.333539993786, 22396.440088997744, 22539.661905071436, 22090.0, 22671.0, 22880.88559557204, 22944.196953106646, 23441.765582344215, 4941.937483441059, 5030.0694371541385, 6199.44205021548, 6409.423151916327, 6432.195975503062, 5660.60375773696, 5973.163757074013, 6246.562740608159, 6393.648349340784, 6430.292667806538, 6141.447269745722, 6370.936290637103, 6384.3934826191435, 6407.935920640781, 6425.518086143535, 5382.2195781611645, 6221.720022598994, 6357.459615932651, 6369.8407539811415, 6371.617702937792, 5394.217838413408, 5566.693831839248, 5626.240457538221, 5633.042382794934, 5639.71801409932, 26113.216603501736, 26498.470030599474, 26499.867500662567, 26777.330566735793, 26964.056258031073, 2009.8191162795272, 2203.4711669199437, 2272.522770218256, 2285.737140228878, 2287.08516593364, 15555.300011499396, 17678.292868285254, 17689.29242830285, 17787.911060444745, 18234.452966410896, 2150.892455377225, 2190.09111218844, 2223.3885681437573, 2229.6321107017325, 2233.9218127365625, 145373.0, 145885.27057364752, 145947.0, 146076.0, 153299.7005044914, 10083.294169408218, 11777.234479758788, 12254.38728063611, 12256.754864902652, 12683.556075537312, 16157.353705851869, 16241.106739129462, 16247.350105995627, 16253.10607916576, 16298.0, 8746.256568191775, 8968.372213944962, 9017.368784185044, 9027.684031058881, 9126.45241285525, 6919.238883722786, 8483.236508714246, 8502.362322825813, 8632.007319158252, 8636.956815215884, 7695.653695583712, 7767.262110099531, 7789.143194248628, 7829.138794732575, 7847.960760196277, 2159.287435146398, 2166.9783302167093, 2168.2844661261747, 2174.4563859035243, 2340.7542208067907, 915.839728047589, 935.4013431403907, 963.5904740485406, 967.2020583018897, 1010.3786171504472, 19275.710864337045, 20233.08951097204, 20688.793112068986, 20875.26936557213, 21165.047572859257, 1003.1673710820002, 1015.751140970467, 1024.7130803375067, 1034.2811745836723, 1035.1451691566529, 9493.145616894513, 10324.122449591869, 10442.0, 10676.306040107369, 10735.731606709895, 577092.0, 673875.0, 675305.0, 685037.0, 699304.0, 116889.0, 154397.68403473956, 156594.0, 161302.1934890318, 163391.0, 1029.248648486609, 1198.748262864808, 1229.5204870100667, 1231.3658465890073, 1232.1313474000988, 17081.52409629517, 21212.893935530225, 21294.893525532272, 22425.542339747863, 22588.661170082134, 62500.374996251274, 62870.05694914672, 62897.0, 64184.35815641784, 64451.35548644453, 70365.0, 90601.0, 91616.54191728999, 92274.53862730644, 92314.0, 7998.720044798404, 8319.710444881053, 8941.37410381267, 8965.820683586422, 9085.863712044456, 13798.965077619017, 13837.86162138406, 13932.721345573234, 13990.481713291705, 14189.503367382093, 10335.431551264752, 10856.34861908288, 11338.319700817978, 11769.470373833026, 11889.108316876442, 11103.278286911325, 11139.220254582102, 11307.491162897853, 11332.886671133183, 11489.94255028753, 11714.197179156505, 11919.986801122002, 12192.939035304767, 12243.510259589517, 12316.384180791103, 8592.484450932963, 8705.303575714055, 8772.91227087721, 8844.204021638083, 8850.380473366802, 9701.320907536405, 11911.987481064207, 12086.818697719717, 12095.879041209828, 12125.939370303446], "value": 10556.203669938079, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.5148872150385, 1409.9788503172447, 1418.8510206428325, 1424.750668632989, 1447.8986470947034, 11489.080873530118, 11822.58620948267, 11896.345700986441, 11912.285262884234, 12293.200941938767, 11825.467853946571, 11895.345755983417, 11972.0, 11982.340971246578, 12006.69983250417, 2483.590207615746, 2545.3127655532994, 2550.9668584223327, 2557.6291437741515, 2563.7564431379083, 2465.6794616699804, 2497.4880149569294, 2528.254165021323, 2540.6951165860123, 2543.5548778963607, 2448.6327050942414, 2504.4239824840297, 2529.595264757639, 2533.64528965944, 2535.366158460385, 2395.544846479172, 2462.7783499485045, 2471.7281099079087, 2472.8269021168526, 2480.268320845355, 2383.5709572276983, 2443.486867757773, 2448.179859746987, 2489.4647650755173, 2495.1017633651873, 9580.329376943617, 11941.402929853473, 11963.46164422603, 11967.521299148024, 11988.940055299669, 6627.37039981201, 6877.2091209511045, 6884.690188941459, 6892.138482689664, 6908.930910690879, 4144.896377590554, 4386.824527018915, 4408.757518336491, 4466.776661166961, 4469.971906461532, 1245.2030700351781, 1269.2511418263268, 1318.9010824188128, 1322.1934619881865, 1323.841139063309, 15804.446844360507, 16520.42178523746, 16579.088150151736, 16584.50246492607, 16651.50045498637, 5162.225666150108, 5609.15862620602, 5719.8570035749435, 5861.238039054895, 5868.94131058684, 11561.248518846249, 12258.325792081521, 12291.56979505713, 12323.75352492963, 12360.25838449696, 6606.372394622503, 6662.86674266512, 6668.333166683293, 6673.866522669519, 6676.9666151668935, 6026.54800889935, 6118.296395914438, 6236.563440559117, 6302.464290535356, 6328.335524769833, 3560.0209942266083, 3804.923901521954, 4393.582609652142, 4453.242948698729, 4489.0, 1307.1506496082477, 1324.4569726412126, 1329.1360615599938, 1333.7265860498574, 1349.2511656030802, 766.1878408886598, 776.4758787818313, 800.3037357499013, 800.3677095094927, 803.4094940218935, 6604.3725846044545, 6945.617991010442, 6951.443884489228, 7004.509684322151, 7316.610033979569, 768.723259626534, 935.1303287942143, 937.8499440089689, 939.9671011514564, 941.275218082073, 4045.2516284487465, 4167.666586673059, 4236.173946080547, 4274.636655884285, 4334.0, 13205.339733013503, 15347.61630959235, 15453.613659658598, 15464.072155670696, 15476.0, 13599.456021759217, 14335.0, 15371.308291126927, 15403.460878869186, 15435.22823858825, 9493.288003399635, 10494.108000819862, 10765.892341076646, 10908.018278354986, 11020.779584408267, 5580.386157522588, 6620.735170593122, 6928.376446119873, 7173.964130179315, 7209.783706488814, 12346.320952347347, 12502.312372819582, 12531.686707832378, 12555.560555380518, 12752.6811829705, 12862.807057893951, 12897.032722546035, 13094.607161785161, 13324.800127998282, 13381.598552043455, 8691.91308086911, 8699.521526316114, 8855.0, 8888.86666700013, 8918.910810891808, 10601.25791194609, 10602.522886470282, 10714.089302409382, 10730.678079657622, 10744.355338679392, 8966.372353935161, 8999.460032398078, 9072.183503484717, 9181.357304988587, 9208.815823683355, 8743.256823169848, 8869.068747781648, 8930.374873758774, 8941.508217048126, 8948.328875334246, 8070.838583228185, 8098.595070246346, 8114.310283625958, 8120.106788253169, 8177.9591102044105, 6077.6961151943115, 6103.816885493442, 6174.783882564088, 6202.4417802398, 6213.347598502092, 5197.688138711689, 6073.453389194994, 6195.070739389128, 6238.438540531374, 6258.718357673824], "value": 5423.938295299192, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.8501404339961, 399.47070132075, 399.77469057339255, 400.19560683027106, 401.59438966643717, 5341.839744807652, 5764.538836893049, 5869.442402971717, 5920.875033743586, 6183.845403864906, 5907.822765317037, 6016.864013275279, 6036.185115009473, 6044.373375974413, 6105.297890742566, 3818.503594532721, 4339.370791235269, 4475.7762111894435, 4599.609033232171, 4609.723416595015, 4629.120467111238, 4646.697964632288, 4646.697964632305, 4653.302004699289, 4671.743054132022, 3898.8440462381614, 4283.01490657149, 4547.795349209294, 4616.838410655628, 4623.606993405565, 3961.1879564689316, 3993.940090898639, 4550.180967425862, 4563.817447302104, 4638.837640682576, 3985.561588225293, 4081.8571350002903, 4086.3257562502154, 4106.117184805281, 4108.465899433055, 5527.226188333637, 5802.564807639402, 5946.197263369433, 5972.9701351493395, 5980.401959804029, 4380.5838445347645, 5194.558462530689, 5265.815696450644, 5273.499017593323, 5285.207218917155, 6102.3287438382185, 6405.583637063576, 6411.519136064814, 6420.133282006916, 6442.0, 3620.71034317254, 3718.4050551911564, 4123.60825721559, 4281.55043720408, 4298.054428025829, 6366.01326794343, 6558.704858281389, 6669.43309818666, 6682.866342673168, 6744.224414192382, 4201.663866890642, 4336.783160841946, 4365.563443655673, 4384.408104905797, 4412.977935110304, 4462.129884672458, 4467.15124126415, 4475.672650221932, 4479.216137175981, 4487.820487180476, 4801.9039619208115, 5001.349824522788, 5242.554382877422, 5244.370675518962, 5263.315768950012, 5326.680399176062, 6472.546921715435, 6502.804915852532, 6514.478841692653, 6566.277709451956, 1163.4764356039816, 1328.6014195741238, 1364.3178410794603, 1523.54293711886, 1550.046721266413, 947.843630770459, 958.6841208817974, 1014.2849291249652, 1016.2428990402198, 1031.3554028732042, 5629.915551266734, 5818.010938140526, 6068.241469816273, 6131.816045518642, 6140.508759299245, 6000.459958603747, 6413.486921046305, 6631.933680663228, 6721.899171512431, 6739.865202695919, 5882.676452795137, 5995.790147344822, 6009.519238460913, 6055.455009049207, 6109.572329936862, 3328.0182346207926, 3337.8831740888954, 3509.701675357623, 3519.2609551993855, 3521.559805024372, 6534.248561415498, 6803.625800581016, 6834.794956151323, 6898.965505172442, 6911.89632155518, 5916.704164791743, 6865.391151362451, 6870.896936545956, 6898.37888096297, 6903.792886213321, 6474.5791523550815, 6698.956818170504, 6715.664216789141, 6890.793276201722, 6914.308569143045, 5296.364436267672, 6657.470161338661, 6670.232923213893, 6709.7651582194385, 6729.596224226562, 5509.614326997232, 5612.214289999321, 6298.433141017331, 6333.701591173891, 6604.075429439787, 6781.220159681502, 6883.449324054164, 6914.0666010088, 6919.446444284546, 6967.477439192182, 4402.911941761083, 4437.179121862466, 4441.888952776207, 4444.000199910118, 4450.532694067206, 6497.740090396331, 6561.40947314744, 6619.968823693931, 6676.0, 6735.966320168368, 5851.0, 6459.869522833579, 6474.482041436768, 6482.189726284215, 6547.083408322934, 5346.251524786455, 5910.911336329872, 6222.408871157233, 6377.298497165215, 6434.613923164625, 6260.154879091265, 6275.309715931336, 6310.3715363667, 6318.27339855904, 6330.303666596763, 5388.595855310946, 6240.906386404116, 6435.581687190318, 6461.483081353386, 6500.5449618526245, 5676.262085928803, 6172.845678858064, 6295.874082518416, 6327.3988971047675, 6330.0504924259885], "value": 4705.78578403618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.7582101190656, 853.9402241843071, 855.8630619100945, 869.0787764969132, 870.2168048756118, 15443.768343474856, 16552.75170872438, 16630.83369166308, 16953.915230423845, 17054.97670139791, 17971.0, 18086.63826723468, 18266.81733182671, 18318.35885743999, 18368.80602760823, 984.8965858584853, 1009.1271050541266, 1011.292095533126, 1012.0, 1017.7557386227326, 986.5363279258737, 1002.3785253143061, 1005.4671024357102, 1009.7425156585098, 1011.6307547745093, 1069.6202847988968, 1072.3244356055714, 1076.1444651502036, 1078.0728573426848, 1078.8597482327286, 1051.7055224537103, 1057.4501259345097, 1072.7532667486482, 1072.8390741388775, 1074.08702602787, 745.9365953893926, 762.2111114996007, 789.6643926331286, 792.0376742258127, 794.6225542867091, 16583.50249492517, 16597.087160206185, 16766.497005089866, 16772.07753573553, 16786.992780433215, 16578.0, 16941.83058169415, 17058.23237954295, 17264.999999999873, 17292.740608890876, 13635.0, 13635.113717608423, 13974.650633734136, 13976.440942362293, 13989.720205595831, 3457.0, 3527.629598892105, 3538.0800991742076, 3539.6991255743037, 3546.184377593168, 97511.0248897509, 116115.0, 121622.39188804087, 122414.38792805979, 123646.0, 13365.997550183774, 13607.31963401826, 13672.658183545293, 13675.931620342033, 13709.108907921152, 24325.391865203157, 25130.497390052464, 25275.24174274775, 25740.97036118572, 25798.87100564485, 9013.278937684969, 9097.13577210164, 9140.314476414296, 9151.725448236564, 9163.770905727277, 4649.18639238132, 4780.928286075712, 4874.707517548958, 4878.512148785164, 4884.633652476007, 4321.935170972438, 4461.2415889298245, 4468.218061839165, 4479.46246450428, 4482.887927801831, 816.979575510617, 942.3074040580168, 981.3670182732097, 986.3145114145743, 988.7182153086336, 642.8039447968321, 645.8966565349522, 646.7865604350553, 651.4885814635583, 674.8076798112514, 11063.0, 11805.631916190892, 12055.0, 12170.208936419105, 12223.572174973833, 656.2223764838682, 660.8215781738903, 662.4766434516678, 674.3660958698807, 687.2097088348339, 5480.558727752322, 5553.6390134641115, 5688.886222275614, 5793.362730099686, 5810.6513609183585, 84907.0, 84947.0, 85867.0, 87646.0, 106479.40280895792, 74986.25013749793, 76849.0, 79079.60460197777, 79673.0, 80866.59566702247, 72325.2767472329, 73035.0, 73187.53624927578, 74005.819592628, 75717.62141189259, 11603.419829008684, 12005.219660722025, 12110.091743119125, 12194.451249693608, 12292.754144917231, 39261.8036909825, 39389.212215756095, 39992.80003599964, 40778.0, 41011.97470063272, 61176.32942023493, 62795.058074128014, 69528.0, 70694.0, 72173.27826721665, 16138.354465821236, 16392.836071639133, 16431.671366572842, 16471.176441177653, 16475.258613362188, 17017.574560636083, 17088.316467341167, 17415.912920435825, 17540.561485962444, 17591.384301549384, 13144.868551314365, 16461.58846028859, 16494.505164845075, 16836.915815420845, 16856.0, 16612.335506579602, 16650.574610201318, 16698.08160551133, 16816.159192040104, 16919.577010574834, 13372.665683357995, 16255.837441625432, 16387.59031024234, 16540.255688494286, 16611.169441527632, 9199.298129846, 11774.411279436164, 12134.757304853676, 12135.211211271593, 12477.93761031189, 12913.806292905427, 13183.53857614979, 13541.05212635106, 13582.59252222435, 13791.655208619464], "value": 8434.783229877035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1685.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 178.0, 161.0, 122.0, 123.0, 124.0, 121.0, 121.0, 119.0, 130.0], "value": 129.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 120.0, 167.0, 115.0, 116.0, 148.0, 152.0, 178.0, 120.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 229.0, 225.0, 225.0, 235.0, 219.0, 213.0, 221.0, 208.0, 218.0], "value": 221.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 61.0, 88.0, 63.0, 77.0, 50.0, 65.0, 107.0, 92.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 72.0, 87.0, 73.0, 72.0, 74.0, 88.0, 74.0, 100.0, 84.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 90.0, 93.0, 141.0, 143.0, 94.0, 92.0, 95.0, 131.0], "value": 106.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 114.0, 155.0, 148.0, 163.0, 117.0, 104.0, 164.0, 100.0], "value": 127.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 108.0, 165.0, 135.0, 102.0, 103.0, 109.0, 103.0, 103.0], "value": 119.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 53.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 62.0, 75.0, 68.0, 76.0, 90.0, 91.0, 61.0, 61.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 117.0, 114.0, 77.0, 106.0, 84.0, 112.0, 114.0, 115.0], "value": 102.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 147.0, 171.0, 170.0, 179.0, 154.0, 151.0, 149.0, 195.0, 188.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 209.0, 262.0, 206.0, 199.0, 203.0, 229.0, 256.0, 218.0, 198.0], "value": 218.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 75.0, 86.0, 72.0, 72.0, 72.0, 74.0, 72.0, 97.0], "value": 76.3, "unit": "score"}]}]} 03:44:34 INFO - Return code: 0 03:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:34 ERROR - # TBPL SUCCESS # 03:44:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:44:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:44:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:44:34 INFO - 2017-04-10 03:44:34.364 screenresolution[1966:19434] starting screenresolution argv=screenresolution get 03:44:34 INFO - 2017-04-10 03:44:34.367 screenresolution[1966:19434] Display 0: 1600x1200x32@60 03:44:34 INFO - 2017-04-10 03:44:34.373 screenresolution[1967:19437] starting screenresolution argv=screenresolution list 03:44:34 INFO - Available Modes on Display 0 03:44:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:44:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:44:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:44:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:44:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:44:34 INFO - Intel Iris: 03:44:34 INFO - Chipset Model: Intel Iris 03:44:34 INFO - Type: GPU 03:44:34 INFO - Bus: Built-In 03:44:34 INFO - VRAM (Dynamic, Max): 1536 MB 03:44:34 INFO - Vendor: Intel (0x8086) 03:44:34 INFO - Device ID: 0x0a2e 03:44:34 INFO - Revision ID: 0x0009 03:44:34 INFO - Displays: 03:44:34 INFO - Display: 03:44:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:44:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:44:34 INFO - Display Serial Number: 1600x1200 60 03:44:34 INFO - Main Display: Yes 03:44:34 INFO - Mirror: Off 03:44:34 INFO - Online: Yes 03:44:34 INFO - Rotation: Supported 03:44:34 INFO - Return code: 0 03:44:34 INFO - Running post-action listener: _resource_record_post_action 03:44:34 INFO - [mozharness: 2017-04-10 10:44:34.622883Z] Finished run-tests step (success) 03:44:34 INFO - Running post-run listener: _resource_record_post_run 03:44:34 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 2191360; Write bytes: 521998336; Read time: 15; Write time: 1640 03:44:34 INFO - TinderboxPrint: CPU usage
54.3% 03:44:34 INFO - TinderboxPrint: I/O read bytes / time
2,191,360 / 15 03:44:34 INFO - TinderboxPrint: I/O write bytes / time
521,998,336 / 1,640 03:44:34 INFO - TinderboxPrint: CPU idle
2,193.9 (45.7%) 03:44:34 INFO - TinderboxPrint: CPU system
968.2 (20.2%) 03:44:34 INFO - TinderboxPrint: CPU user
1,639.6 (34.1%) 03:44:34 INFO - TinderboxPrint: Swap in / out
210,001,920 / 0 03:44:34 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208620032; Write bytes: 209975296; Read time: 16027; Write time: 457 03:44:34 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 618496; Write bytes: 310429696; Read time: 11; Write time: 1173 03:44:35 INFO - Running post-run listener: _upload_blobber_files 03:44:35 INFO - Blob upload gear active. 03:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:35 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:44:35 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:44:35 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:44:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:44:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:36 INFO - (blobuploader) - INFO - Done attempting. 03:44:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:44:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:37 INFO - (blobuploader) - INFO - Done attempting. 03:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:38 INFO - (blobuploader) - INFO - Done attempting. 03:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:40 INFO - (blobuploader) - INFO - Done attempting. 03:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:40 INFO - Return code: 0 03:44:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e7ca505b032e7ec0d743cdb65db4845e1453dfab22f7493ed304409948490644e438f5b3fe0d180f8ee031dff79666911c40332d574eeccf5ce7702351b879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97bc8c8271d344702a790b137fd469affa3be7667fe8a04422456e9952e859c9fcd43145c60e787d23a449339bd18c41181e9c76fe679683f8fd3ac070225537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4b91ed39305d82f94e8d71a6eb7d9364c9331b356fcf94a28933f3fb0e26691d9f65389b516c421287a558f6ab33d9f2e21962045167357feb236b32705356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5092111cb767a618eaca4aab992ba61054fb4ed9f4c1e93c793664f9120371452a9a3479f70a003fba5cca51e36ce5bf01a09051c422c0aed55d604b319d4635"} 03:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:40 INFO - Contents: 03:44:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/38e7ca505b032e7ec0d743cdb65db4845e1453dfab22f7493ed304409948490644e438f5b3fe0d180f8ee031dff79666911c40332d574eeccf5ce7702351b879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97bc8c8271d344702a790b137fd469affa3be7667fe8a04422456e9952e859c9fcd43145c60e787d23a449339bd18c41181e9c76fe679683f8fd3ac070225537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4b91ed39305d82f94e8d71a6eb7d9364c9331b356fcf94a28933f3fb0e26691d9f65389b516c421287a558f6ab33d9f2e21962045167357feb236b32705356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5092111cb767a618eaca4aab992ba61054fb4ed9f4c1e93c793664f9120371452a9a3479f70a003fba5cca51e36ce5bf01a09051c422c0aed55d604b319d4635"} 03:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:40 INFO - Copying logs to upload dir... 03:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.352284 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-10 03:44:40.794774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 03:44:40.798362) ========= 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.m2JoYdD8CN/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.npIDiEOSDU/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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/38e7ca505b032e7ec0d743cdb65db4845e1453dfab22f7493ed304409948490644e438f5b3fe0d180f8ee031dff79666911c40332d574eeccf5ce7702351b879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97bc8c8271d344702a790b137fd469affa3be7667fe8a04422456e9952e859c9fcd43145c60e787d23a449339bd18c41181e9c76fe679683f8fd3ac070225537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4b91ed39305d82f94e8d71a6eb7d9364c9331b356fcf94a28933f3fb0e26691d9f65389b516c421287a558f6ab33d9f2e21962045167357feb236b32705356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5092111cb767a618eaca4aab992ba61054fb4ed9f4c1e93c793664f9120371452a9a3479f70a003fba5cca51e36ce5bf01a09051c422c0aed55d604b319d4635"} build_url:https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/IO9ptuaXSKSFK4B81nM6bw/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/38e7ca505b032e7ec0d743cdb65db4845e1453dfab22f7493ed304409948490644e438f5b3fe0d180f8ee031dff79666911c40332d574eeccf5ce7702351b879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97bc8c8271d344702a790b137fd469affa3be7667fe8a04422456e9952e859c9fcd43145c60e787d23a449339bd18c41181e9c76fe679683f8fd3ac070225537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4b91ed39305d82f94e8d71a6eb7d9364c9331b356fcf94a28933f3fb0e26691d9f65389b516c421287a558f6ab33d9f2e21962045167357feb236b32705356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5092111cb767a618eaca4aab992ba61054fb4ed9f4c1e93c793664f9120371452a9a3479f70a003fba5cca51e36ce5bf01a09051c422c0aed55d604b319d4635"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 03:44:40.833502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 03:44:40.833890) ========= 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.m2JoYdD8CN/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.npIDiEOSDU/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.005253 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 03:44:40.882853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 03:44:40.883210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 03:44:40.883564) ========= ========= Total master_lag: 0.19 =========