builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0344 starttime: 1493685380.85 results: success (0) buildid: 20170501154021 builduid: d123d4c040de4715b57a930398001ba7 revision: 4168f0fec8342bd1dbaa7631eb9575716131cb36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:20.848484) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:20.848932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:20.849201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:20.876200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:20.876579) ========= 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.aekHdqMSiv/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.dO7JeUXVP0/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-05-01 17:36:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 57.5M=0s 2017-05-01 17:36:21 (57.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:21.030597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:21.031064) ========= 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.aekHdqMSiv/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.dO7JeUXVP0/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.026780 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:21.080627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 17:36:21.080975) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4168f0fec8342bd1dbaa7631eb9575716131cb36 --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 4168f0fec8342bd1dbaa7631eb9575716131cb36 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aekHdqMSiv/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.dO7JeUXVP0/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-05-01 17:36:21,184 truncating revision to first 12 chars 2017-05-01 17:36:21,184 Setting DEBUG logging. 2017-05-01 17:36:21,184 attempt 1/10 2017-05-01 17:36:21,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4168f0fec834?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 17:36:22,888 unpacking tar archive at: mozilla-central-4168f0fec834/testing/mozharness/ program finished with exit code 0 elapsedTime=1.982888 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-01 17:36:23.088943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:23.089532) ========= script_repo_revision: 4168f0fec8342bd1dbaa7631eb9575716131cb36 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:23.090070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:23.090456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 17:36:23.111398) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-05-01 17:36:23.111900) ========= /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.aekHdqMSiv/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.dO7JeUXVP0/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:36:23 INFO - MultiFileLogger online at 20170501 17:36:23 in /builds/slave/test 17:36:23 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 17:36:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:23 INFO - {'append_to_log': False, 17:36:23 INFO - 'base_work_dir': '/builds/slave/test', 17:36:23 INFO - 'blob_upload_branch': 'Firefox', 17:36:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:23 INFO - 'branch': 'Firefox', 17:36:23 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:23 INFO - 'config_files': ('talos/mac_config.py',), 17:36:23 INFO - 'default_actions': ('clobber', 17:36:23 INFO - 'read-buildbot-config', 17:36:23 INFO - 'download-and-extract', 17:36:23 INFO - 'populate-webroot', 17:36:23 INFO - 'create-virtualenv', 17:36:23 INFO - 'install', 17:36:23 INFO - 'run-tests'), 17:36:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:23 INFO - 'download_minidump_stackwalk': True, 17:36:23 INFO - 'download_symbols': 'ondemand', 17:36:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:23 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:23 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:23 INFO - 'gecko_profile': False, 17:36:23 INFO - 'gecko_profile_interval': 0, 17:36:23 INFO - 'installer_path': 'installer.exe', 17:36:23 INFO - 'log_level': 'info', 17:36:23 INFO - 'log_name': 'talos', 17:36:23 INFO - 'log_to_console': True, 17:36:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:36:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:36:23 INFO - 'opt_config_files': (), 17:36:23 INFO - 'pip_index': False, 17:36:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:23 INFO - 'cmd': ('bash', 17:36:23 INFO - '-c', 17:36:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:23 INFO - 'enabled': True, 17:36:23 INFO - 'halt_on_failure': False, 17:36:23 INFO - 'name': 'check_screen_resolution'},), 17:36:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:23 INFO - 'cmd': ('bash', 17:36:23 INFO - '-c', 17:36:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:23 INFO - 'enabled': True, 17:36:23 INFO - 'halt_on_failure': False, 17:36:23 INFO - 'name': 'check_screen_resolution'},), 17:36:23 INFO - 'run_cmd_checks_enabled': True, 17:36:23 INFO - 'suite': 'dromaeojs-e10s', 17:36:23 INFO - 'system_bits': '32', 17:36:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:23 INFO - 'title': 't-yosemite-r7-0344', 17:36:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:23 INFO - 'use_talos_json': True, 17:36:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:23 INFO - 'work_dir': 'build'} 17:36:23 INFO - [mozharness: 2017-05-02 00:36:23.323797Z] Running clobber step. 17:36:23 INFO - Running pre-action listener: _resource_record_pre_action 17:36:23 INFO - Running main action method: clobber 17:36:23 INFO - rmtree: /builds/slave/test/build 17:36:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:25 INFO - Running post-action listener: _resource_record_post_action 17:36:25 INFO - [mozharness: 2017-05-02 00:36:25.700301Z] Finished clobber step (success) 17:36:25 INFO - [mozharness: 2017-05-02 00:36:25.700425Z] Running read-buildbot-config step. 17:36:25 INFO - Running pre-action listener: _resource_record_pre_action 17:36:25 INFO - Running main action method: read_buildbot_config 17:36:25 INFO - Using buildbot properties: 17:36:25 INFO - { 17:36:25 INFO - "project": "", 17:36:25 INFO - "product": "firefox", 17:36:25 INFO - "script_repo_revision": "production", 17:36:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:36:25 INFO - "repository": "", 17:36:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:36:25 INFO - "buildid": "20170501154021", 17:36:25 INFO - "pgo_build": "False", 17:36:25 INFO - "basedir": "/builds/slave/test", 17:36:25 INFO - "buildnumber": 207, 17:36:25 INFO - "slavename": "t-yosemite-r7-0344", 17:36:25 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:36:25 INFO - "platform": "yosemite_r7", 17:36:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:36:25 INFO - "branch": "mozilla-central", 17:36:25 INFO - "repo_path": "mozilla-central", 17:36:25 INFO - "revision": "4168f0fec8342bd1dbaa7631eb9575716131cb36", 17:36:25 INFO - "stage_platform": "macosx64", 17:36:25 INFO - "builduid": "d123d4c040de4715b57a930398001ba7", 17:36:25 INFO - "slavebuilddir": "test" 17:36:25 INFO - } 17:36:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:36:25 INFO - Running post-action listener: _resource_record_post_action 17:36:25 INFO - [mozharness: 2017-05-02 00:36:25.703932Z] Finished read-buildbot-config step (success) 17:36:25 INFO - [mozharness: 2017-05-02 00:36:25.704076Z] Running download-and-extract step. 17:36:25 INFO - Running pre-action listener: _resource_record_pre_action 17:36:25 INFO - Running main action method: download_and_extract 17:36:25 INFO - mkdir: /builds/slave/test/build/tests 17:36:25 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')]} 17:36:25 INFO - trying https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:36:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/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 17:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/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 17:36:26 INFO - Downloaded 1325 bytes. 17:36:26 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:36:26 INFO - Using the following test package requirements: 17:36:26 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:36:26 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:36:26 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:36:26 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:36:26 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'jsshell-mac.zip'], 17:36:26 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:36:26 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:36:26 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:36:26 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:36:26 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:36:26 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:36:26 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:36:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:36:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:36:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:36:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:36:28 INFO - Content-Length response header: 52698561 17:36:28 INFO - Bytes received: 52698561 17:36:44 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 17:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:36:46 INFO - Content-Length response header: 52698561 17:36:46 INFO - Bytes received: 52698561 17:37:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:37:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:37:03 INFO - Content-Length response header: 14408811 17:37:03 INFO - Bytes received: 14408811 17:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:03 INFO - trying https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/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 17:37:05 INFO - Downloaded 71242021 bytes. 17:37:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:37:05 INFO - mkdir: /builds/slave/test/properties 17:37:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:37:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:37:05 INFO - Contents: 17:37:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:37:06 INFO - Running post-action listener: _resource_record_post_action 17:37:06 INFO - Running post-action listener: set_extra_try_arguments 17:37:06 INFO - [mozharness: 2017-05-02 00:37:06.021488Z] Finished download-and-extract step (success) 17:37:06 INFO - [mozharness: 2017-05-02 00:37:06.021642Z] Running populate-webroot step. 17:37:06 INFO - Running pre-action listener: _resource_record_pre_action 17:37:06 INFO - Running main action method: populate_webroot 17:37:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:37:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:37:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:37:06 INFO - '--tppagecycles', 17:37:06 INFO - '7'], 17:37:06 INFO - 'tests': ['tsvgm']}}, 17:37:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:37:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:37:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:37:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:37:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:37:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:37:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['damp', 'tps']}, 17:37:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'tests': ['damp', 'tps']}, 17:37:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['dromaeo_dom']}, 17:37:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:37:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:37:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:37:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['a11yr', 17:37:06 INFO - 'ts_paint', 17:37:06 INFO - 'tpaint', 17:37:06 INFO - 'sessionrestore', 17:37:06 INFO - 'sessionrestore_no_auto_restore', 17:37:06 INFO - 'tabpaint']}, 17:37:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:37:06 INFO - 'ts_paint', 17:37:06 INFO - 'tpaint', 17:37:06 INFO - 'sessionrestore', 17:37:06 INFO - 'sessionrestore_no_auto_restore', 17:37:06 INFO - 'tabpaint']}, 17:37:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:37:06 INFO - 'ts_paint', 17:37:06 INFO - 'tpaint', 17:37:06 INFO - 'sessionrestore', 17:37:06 INFO - 'sessionrestore_no_auto_restore', 17:37:06 INFO - 'tabpaint']}, 17:37:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:37:06 INFO - 'ts_paint', 17:37:06 INFO - 'tpaint', 17:37:06 INFO - 'sessionrestore', 17:37:06 INFO - 'sessionrestore_no_auto_restore', 17:37:06 INFO - 'tabpaint']}, 17:37:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['a11yr', 17:37:06 INFO - 'ts_paint', 17:37:06 INFO - 'tpaint', 17:37:06 INFO - 'sessionrestore', 17:37:06 INFO - 'sessionrestore_no_auto_restore', 17:37:06 INFO - 'tabpaint']}, 17:37:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['a11yr', 17:37:06 INFO - 'ts_paint', 17:37:06 INFO - 'tpaint', 17:37:06 INFO - 'sessionrestore', 17:37:06 INFO - 'sessionrestore_no_auto_restore', 17:37:06 INFO - 'tabpaint']}, 17:37:06 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:37:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:37:06 INFO - 'bloom_basic_ref']}, 17:37:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['tsvgx', 17:37:06 INFO - 'tsvgr_opacity', 17:37:06 INFO - 'tart', 17:37:06 INFO - 'tscrollx', 17:37:06 INFO - 'cart', 17:37:06 INFO - 'tsvg_static']}, 17:37:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:37:06 INFO - 'tsvgr_opacity', 17:37:06 INFO - 'tart', 17:37:06 INFO - 'tscrollx', 17:37:06 INFO - 'cart', 17:37:06 INFO - 'tsvg_static']}, 17:37:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'talos_options': ['--disable-e10s'], 17:37:06 INFO - 'tests': ['tp5o']}, 17:37:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:37:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'talos_options': ['--disable-e10s', 17:37:06 INFO - '--xperf_path', 17:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:37:06 INFO - 'tests': ['tp5n']}, 17:37:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:37:06 INFO - 'talos_options': ['--xperf_path', 17:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:37:06 INFO - 'tests': ['tp5n']}}, 17:37:06 INFO - 'talos.zip': {'path': '', 17:37:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:37:06 INFO - Running post-action listener: _resource_record_post_action 17:37:06 INFO - [mozharness: 2017-05-02 00:37:06.040882Z] Finished populate-webroot step (success) 17:37:06 INFO - [mozharness: 2017-05-02 00:37:06.041000Z] Running create-virtualenv step. 17:37:06 INFO - Running pre-action listener: _resource_record_pre_action 17:37:06 INFO - Running main action method: create_virtualenv 17:37:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:37:06 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 17:37:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:37:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:37:06 INFO - Using real prefix '/tools/python27' 17:37:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:37:06 INFO - Installing distribute.............................................................................................................................................................................................done. 17:37:09 INFO - Installing pip.................done. 17:37:09 INFO - Return code: 0 17:37:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:37:10 INFO - Reading from file tmpfile_stdout 17:37:10 INFO - Output received: 17:37:10 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) 17:37:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37: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', 'pip>=1.5'] in /builds/slave/test/build 17:37: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 pip>=1.5 17:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:10 INFO - 'HOME': '/Users/cltbld', 17:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:10 INFO - 'LOGNAME': 'cltbld', 17:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:10 INFO - 'MOZ_NO_REMOTE': '1', 17:37:10 INFO - 'NO_EM_RESTART': '1', 17:37:10 INFO - 'PAGER': '/bin/cat', 17:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:10 INFO - 'PWD': '/builds/slave/test', 17:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:10 INFO - 'SHELL': '/bin/bash', 17:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:10 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:10 INFO - 'USER': 'cltbld', 17:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:10 INFO - 'XPC_FLAGS': '0x0', 17:37:10 INFO - 'XPC_SERVICE_NAME': '0', 17:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:10 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 17:37:10 INFO - Cleaning up... 17:37:10 INFO - Return code: 0 17:37:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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', '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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:37: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 psutil>=3.1.1 17:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:10 INFO - 'HOME': '/Users/cltbld', 17:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:10 INFO - 'LOGNAME': 'cltbld', 17:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:10 INFO - 'MOZ_NO_REMOTE': '1', 17:37:10 INFO - 'NO_EM_RESTART': '1', 17:37:10 INFO - 'PAGER': '/bin/cat', 17:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:10 INFO - 'PWD': '/builds/slave/test', 17:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:10 INFO - 'SHELL': '/bin/bash', 17:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:10 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:10 INFO - 'USER': 'cltbld', 17:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:10 INFO - 'XPC_FLAGS': '0x0', 17:37:10 INFO - 'XPC_SERVICE_NAME': '0', 17:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:10 INFO - Downloading/unpacking psutil>=3.1.1 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:37:14 INFO - Installing collected packages: psutil 17:37:14 INFO - Running setup.py install for psutil 17:37:14 INFO - building 'psutil._psutil_osx' extension 17:37:14 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 17:37:14 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 17:37:14 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 17:37:14 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 17:37:15 INFO - building 'psutil._psutil_posix' extension 17:37:15 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 17:37:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:37:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:37:15 INFO - ^ 17:37:15 INFO - 1 warning generated. 17:37:15 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 17:37:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:37:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:37:15 INFO - Successfully installed psutil 17:37:15 INFO - Cleaning up... 17:37:15 INFO - Return code: 0 17:37:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:15 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:15 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 17:37:15 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 17:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:15 INFO - 'HOME': '/Users/cltbld', 17:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:15 INFO - 'LOGNAME': 'cltbld', 17:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:15 INFO - 'MOZ_NO_REMOTE': '1', 17:37:15 INFO - 'NO_EM_RESTART': '1', 17:37:15 INFO - 'PAGER': '/bin/cat', 17:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:15 INFO - 'PWD': '/builds/slave/test', 17:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:15 INFO - 'SHELL': '/bin/bash', 17:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:15 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:15 INFO - 'USER': 'cltbld', 17:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:15 INFO - 'XPC_FLAGS': '0x0', 17:37:15 INFO - 'XPC_SERVICE_NAME': '0', 17:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:37:15 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 17:37:15 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 17:37:15 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 17:37:15 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 17:37:15 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 17:37:15 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 17:37:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:37:18 INFO - Installing collected packages: mozsystemmonitor 17:37:18 INFO - Running setup.py install for mozsystemmonitor 17:37:18 INFO - Successfully installed mozsystemmonitor 17:37:18 INFO - Cleaning up... 17:37:18 INFO - Return code: 0 17:37:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:19 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:19 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 17:37:19 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 17:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:19 INFO - 'HOME': '/Users/cltbld', 17:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:19 INFO - 'LOGNAME': 'cltbld', 17:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:19 INFO - 'MOZ_NO_REMOTE': '1', 17:37:19 INFO - 'NO_EM_RESTART': '1', 17:37:19 INFO - 'PAGER': '/bin/cat', 17:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:19 INFO - 'PWD': '/builds/slave/test', 17:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:19 INFO - 'SHELL': '/bin/bash', 17:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:19 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:19 INFO - 'USER': 'cltbld', 17:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:19 INFO - 'XPC_FLAGS': '0x0', 17:37:19 INFO - 'XPC_SERVICE_NAME': '0', 17:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 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 17:37:19 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 17:37:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:37:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37: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 17:37:23 INFO - Downloading functools32-3.2.3-2.tar.gz 17:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:37:23 INFO - warning: no files found matching '*.txt' 17:37:23 INFO - no previously-included directories found matching 'build' 17:37:23 INFO - no previously-included directories found matching 'dist' 17:37:23 INFO - no previously-included directories found matching '.git*' 17:37:23 INFO - Installing collected packages: jsonschema, functools32 17:37:23 INFO - Running setup.py install for functools32 17:37:23 INFO - warning: no files found matching '*.txt' 17:37:23 INFO - no previously-included directories found matching 'build' 17:37:23 INFO - no previously-included directories found matching 'dist' 17:37:23 INFO - no previously-included directories found matching '.git*' 17:37:23 INFO - Successfully installed jsonschema functools32 17:37:23 INFO - Cleaning up... 17:37:23 INFO - Return code: 0 17:37:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:23 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:23 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 17:37:23 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 17:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:23 INFO - 'HOME': '/Users/cltbld', 17:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:23 INFO - 'LOGNAME': 'cltbld', 17:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:23 INFO - 'MOZ_NO_REMOTE': '1', 17:37:23 INFO - 'NO_EM_RESTART': '1', 17:37:23 INFO - 'PAGER': '/bin/cat', 17:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:23 INFO - 'PWD': '/builds/slave/test', 17:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:23 INFO - 'SHELL': '/bin/bash', 17:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:23 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:23 INFO - 'USER': 'cltbld', 17:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:23 INFO - 'XPC_FLAGS': '0x0', 17:37:23 INFO - 'XPC_SERVICE_NAME': '0', 17:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:37:23 INFO - Cleaning up... 17:37:23 INFO - Return code: 0 17:37:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:23 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:23 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 17:37:23 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 17:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:23 INFO - 'HOME': '/Users/cltbld', 17:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:23 INFO - 'LOGNAME': 'cltbld', 17:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:23 INFO - 'MOZ_NO_REMOTE': '1', 17:37:23 INFO - 'NO_EM_RESTART': '1', 17:37:23 INFO - 'PAGER': '/bin/cat', 17:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:23 INFO - 'PWD': '/builds/slave/test', 17:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:23 INFO - 'SHELL': '/bin/bash', 17:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:23 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:23 INFO - 'USER': 'cltbld', 17:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:23 INFO - 'XPC_FLAGS': '0x0', 17:37:23 INFO - 'XPC_SERVICE_NAME': '0', 17:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:23 INFO - Downloading/unpacking blobuploader==1.2.4 17:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:37:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:37:26 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 17:37:26 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 17:37:26 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 17:37:26 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 17:37:26 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 17:37:26 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 17:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:37:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:27 INFO - Downloading docopt-0.6.1.tar.gz 17:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:37:27 INFO - Installing collected packages: blobuploader, requests, docopt 17:37:27 INFO - Running setup.py install for blobuploader 17:37:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:37:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:37:27 INFO - Running setup.py install for requests 17:37:28 INFO - Running setup.py install for docopt 17:37:28 INFO - Successfully installed blobuploader requests docopt 17:37:28 INFO - Cleaning up... 17:37:28 INFO - Return code: 0 17:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:28 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:28 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 17:37:28 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 17:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:28 INFO - 'HOME': '/Users/cltbld', 17:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:28 INFO - 'LOGNAME': 'cltbld', 17:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:28 INFO - 'MOZ_NO_REMOTE': '1', 17:37:28 INFO - 'NO_EM_RESTART': '1', 17:37:28 INFO - 'PAGER': '/bin/cat', 17:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:28 INFO - 'PWD': '/builds/slave/test', 17:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:28 INFO - 'SHELL': '/bin/bash', 17:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:28 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:28 INFO - 'USER': 'cltbld', 17:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:28 INFO - 'XPC_FLAGS': '0x0', 17:37:28 INFO - 'XPC_SERVICE_NAME': '0', 17:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-EhJQlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-acu1X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-iAYDFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-3ulaKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ulHDFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-EO7UKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-1sNpbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-kB4aKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-L6MqxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:29 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-0drR8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-JZi3QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-qy17Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-eG1PXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-QyVUKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-XQZnf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-FMKGww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:30 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-sI78d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:37:30 INFO - Running setup.py install for manifestparser 17:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:37:30 INFO - Running setup.py install for mozcrash 17:37:31 INFO - Running setup.py install for mozdebug 17:37:31 INFO - Running setup.py install for mozdevice 17:37:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Running setup.py install for mozfile 17:37:31 INFO - Running setup.py install for mozhttpd 17:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Running setup.py install for mozinfo 17:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Running setup.py install for mozInstall 17:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:37:31 INFO - Running setup.py install for mozleak 17:37:32 INFO - Running setup.py install for mozlog 17:37:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:37:32 INFO - Running setup.py install for moznetwork 17:37:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:37:32 INFO - Running setup.py install for mozprocess 17:37:32 INFO - Running setup.py install for mozprofile 17:37:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:37:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:37:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:37:32 INFO - Running setup.py install for mozrunner 17:37:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:37:32 INFO - Running setup.py install for mozscreenshot 17:37:33 INFO - Running setup.py install for moztest 17:37:33 INFO - Running setup.py install for mozversion 17:37:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:37:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:37:33 INFO - Cleaning up... 17:37:33 INFO - Return code: 0 17:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37: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')]} 17:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37: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')]} 17:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:33 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:33 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 17:37:33 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 17:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:33 INFO - 'HOME': '/Users/cltbld', 17:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:33 INFO - 'LOGNAME': 'cltbld', 17:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:33 INFO - 'MOZ_NO_REMOTE': '1', 17:37:33 INFO - 'NO_EM_RESTART': '1', 17:37:33 INFO - 'PAGER': '/bin/cat', 17:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:33 INFO - 'PWD': '/builds/slave/test', 17:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:33 INFO - 'SHELL': '/bin/bash', 17:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:33 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:33 INFO - 'USER': 'cltbld', 17:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:33 INFO - 'XPC_FLAGS': '0x0', 17:37:33 INFO - 'XPC_SERVICE_NAME': '0', 17:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:37:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Zo6k6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:37:33 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)) 17:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:37:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-7Pqw70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:37:33 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)) 17:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:37:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-CHawNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:37:33 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)) 17:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:37:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Z09bmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-t36YY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-f6BKKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-f_QXlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-KVFNAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-RX3w9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-DhxRE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-YiT7tS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-OTFJzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:37:34 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)) 17:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:37:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-vOwC4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:37:35 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)) 17:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:37:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-cPiWn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:37:35 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)) 17:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-fkoW6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:37:35 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)) 17:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:37:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-rjxb9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:37:35 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)) 17:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:37:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-CNKy0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:37:35 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)) 17:37:35 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)) 17:37:35 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)) 17:37:35 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)) 17:37:35 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)) 17:37:35 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)) 17:37:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:37:38 INFO - Downloading blessings-1.6.tar.gz 17:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:37:38 INFO - Installing collected packages: blessings 17:37:38 INFO - Running setup.py install for blessings 17:37:38 INFO - Successfully installed blessings 17:37:38 INFO - Cleaning up... 17:37:38 INFO - Return code: 0 17:37:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:38 INFO - Reading from file tmpfile_stdout 17:37:38 INFO - Current package versions: 17:37:38 INFO - blessings == 1.6 17:37:38 INFO - blobuploader == 1.2.4 17:37:38 INFO - docopt == 0.6.1 17:37:38 INFO - functools32 == 3.2.3-2 17:37:38 INFO - jsonschema == 2.5.1 17:37:38 INFO - manifestparser == 1.1 17:37:38 INFO - mozInstall == 1.12 17:37:38 INFO - mozcrash == 1.0 17:37:38 INFO - mozdebug == 0.1 17:37:38 INFO - mozdevice == 0.50 17:37:38 INFO - mozfile == 1.2 17:37:38 INFO - mozhttpd == 0.7 17:37:38 INFO - mozinfo == 0.9 17:37:38 INFO - mozleak == 0.1 17:37:38 INFO - mozlog == 3.4 17:37:38 INFO - moznetwork == 0.27 17:37:38 INFO - mozprocess == 0.25 17:37:38 INFO - mozprofile == 0.28 17:37:38 INFO - mozrunner == 6.13 17:37:38 INFO - mozscreenshot == 0.1 17:37:38 INFO - mozsystemmonitor == 0.3 17:37:38 INFO - moztest == 0.8 17:37:38 INFO - mozversion == 1.4 17:37:38 INFO - psutil == 3.1.1 17:37:38 INFO - requests == 1.2.3 17:37:38 INFO - wsgiref == 0.1.2 17:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:38 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:38 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 17:37:38 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 17:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:38 INFO - 'HOME': '/Users/cltbld', 17:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:38 INFO - 'LOGNAME': 'cltbld', 17:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:38 INFO - 'MOZ_NO_REMOTE': '1', 17:37:38 INFO - 'NO_EM_RESTART': '1', 17:37:38 INFO - 'PAGER': '/bin/cat', 17:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:38 INFO - 'PWD': '/builds/slave/test', 17:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:38 INFO - 'SHELL': '/bin/bash', 17:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:38 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:38 INFO - 'USER': 'cltbld', 17:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:38 INFO - 'XPC_FLAGS': '0x0', 17:37:38 INFO - 'XPC_SERVICE_NAME': '0', 17:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 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)) 17:37:38 INFO - Cleaning up... 17:37:38 INFO - Return code: 0 17:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:37:38 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 0x10ddd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb59b4ce0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, '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.aekHdqMSiv/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.dO7JeUXVP0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 17:37:38 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 17:37:38 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 17:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:38 INFO - 'HOME': '/Users/cltbld', 17:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:38 INFO - 'LOGNAME': 'cltbld', 17:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:38 INFO - 'MOZ_NO_REMOTE': '1', 17:37:38 INFO - 'NO_EM_RESTART': '1', 17:37:38 INFO - 'PAGER': '/bin/cat', 17:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:38 INFO - 'PWD': '/builds/slave/test', 17:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:38 INFO - 'SHELL': '/bin/bash', 17:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:37:38 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:38 INFO - 'USER': 'cltbld', 17:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:38 INFO - 'XPC_FLAGS': '0x0', 17:37:38 INFO - 'XPC_SERVICE_NAME': '0', 17:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:37:39 INFO - Cleaning up... 17:37:39 INFO - Return code: 0 17:37:39 INFO - Running post-action listener: _resource_record_post_action 17:37:39 INFO - Running post-action listener: _start_resource_monitoring 17:37:39 INFO - Starting resource monitoring. 17:37:39 INFO - [mozharness: 2017-05-02 00:37:39.273369Z] Finished create-virtualenv step (success) 17:37:39 INFO - [mozharness: 2017-05-02 00:37:39.274194Z] Running install step. 17:37:39 INFO - Running pre-action listener: _resource_record_pre_action 17:37:39 INFO - Running main action method: install 17:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:37:39 INFO - Reading from file tmpfile_stdout 17:37:39 INFO - Detecting whether we're running mozinstall >=1.0... 17:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:37:39 INFO - Reading from file tmpfile_stdout 17:37:39 INFO - Output received: 17:37:39 INFO - Usage: mozinstall [options] installer 17:37:39 INFO - Options: 17:37:39 INFO - -h, --help show this help message and exit 17:37:39 INFO - -d DEST, --destination=DEST 17:37:39 INFO - Directory to install application into. [default: 17:37:39 INFO - "/builds/slave/test"] 17:37:39 INFO - --app=APP Application being installed. [default: firefox] 17:37:39 INFO - mkdir: /builds/slave/test/build/application 17:37:39 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'] 17:37:39 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 17:37:59 INFO - Reading from file tmpfile_stdout 17:37:59 INFO - Output received: 17:37:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:37:59 INFO - Running post-action listener: _resource_record_post_action 17:37:59 INFO - [mozharness: 2017-05-02 00:37:59.664504Z] Finished install step (success) 17:37:59 INFO - [mozharness: 2017-05-02 00:37:59.664653Z] Running run-tests step. 17:37:59 INFO - Running pre-action listener: _resource_record_pre_action 17:37:59 INFO - Running main action method: run_tests 17:37:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:59 INFO - 2017-05-01 17:37:59.679 screenresolution[1626:7306] starting screenresolution argv=screenresolution get 17:37:59 INFO - 2017-05-01 17:37:59.681 screenresolution[1626:7306] Display 0: 1600x1200x32@60 17:37:59 INFO - 2017-05-01 17:37:59.687 screenresolution[1627:7309] starting screenresolution argv=screenresolution list 17:37:59 INFO - Available Modes on Display 0 17:37:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:59 INFO - Intel Iris: 17:37:59 INFO - Chipset Model: Intel Iris 17:37:59 INFO - Type: GPU 17:37:59 INFO - Bus: Built-In 17:37:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:59 INFO - Vendor: Intel (0x8086) 17:37:59 INFO - Device ID: 0x0a2e 17:37:59 INFO - Revision ID: 0x0009 17:37:59 INFO - Displays: 17:37:59 INFO - Display: 17:37:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:59 INFO - Display Serial Number: 1600x1200 60 17:37:59 INFO - Main Display: Yes 17:37:59 INFO - Mirror: Off 17:37:59 INFO - Online: Yes 17:37:59 INFO - Rotation: Supported 17:37:59 INFO - Return code: 0 17:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:59 INFO - Python 2.7.3 17:37:59 INFO - Return code: 0 17:37:59 INFO - grabbing minidump binary from tooltool 17:37:59 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')]} 17:37:59 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 0x10dbb1d30>, '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 0x10dad7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dba6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:59 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 17:37:59 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 17:37:59 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 17:38:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:38:00 INFO - Return code: 0 17:38:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:38:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:38:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:38:00 INFO - ENV: RUST_BACKTRACE is now 1 17:38:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:38:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:38:00 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/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 17:38:00 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/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --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 17:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aekHdqMSiv/Render', 17:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:00 INFO - 'HOME': '/Users/cltbld', 17:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:00 INFO - 'LOGNAME': 'cltbld', 17:38:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:38:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:00 INFO - 'MOZ_NO_REMOTE': '1', 17:38:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:38:00 INFO - 'NO_EM_RESTART': '1', 17:38:00 INFO - 'PAGER': '/bin/cat', 17:38:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:00 INFO - 'PWD': '/builds/slave/test', 17:38:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:00 INFO - 'RUST_BACKTRACE': '1', 17:38:00 INFO - 'SHELL': '/bin/bash', 17:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dO7JeUXVP0/Listeners', 17:38:00 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 17:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:00 INFO - 'USER': 'cltbld', 17:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:00 INFO - 'XPC_FLAGS': '0x0', 17:38:00 INFO - 'XPC_SERVICE_NAME': '0', 17:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:00 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/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 17:38:00 INFO - mozversion application_buildid: 20170501154021 17:38:00 INFO - mozversion application_changeset: 4168f0fec8342bd1dbaa7631eb9575716131cb36 17:38:00 INFO - mozversion application_display_name: Nightly 17:38:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:38:00 INFO - mozversion application_name: Firefox 17:38:00 INFO - mozversion application_remotingname: firefox 17:38:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:38:00 INFO - mozversion application_vendor: Mozilla 17:38:00 INFO - mozversion application_version: 55.0a1 17:38:00 INFO - mozversion platform_buildid: 20170501154021 17:38:00 INFO - mozversion platform_changeset: 4168f0fec8342bd1dbaa7631eb9575716131cb36 17:38:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:38:00 INFO - mozversion platform_version: 55.0a1 17:38:00 INFO - using testdate: 1493685480 17:38:00 INFO - actual date: 1493685480 17:38:00 INFO - starting webserver on 'localhost:49229' 17:38:00 INFO - SUITE-START | Running 2 tests 17:38:00 INFO - TEST-START | dromaeo_css 17:38:00 INFO - operating with platform_type : mac_ 17:38:00 INFO - Initialising browser for dromaeo_css test... 17:38:00 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpyiMVOJ/profile http://localhost:49229/getInfo.html) 17:38:03 INFO - PID 1637 | 2017-05-01 17:38:03.302 plugin-container[1639:7495] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9843, name = 'com.apple.tsm.portname' 17:38:03 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:38:03 INFO - PID 1637 | 2017-05-01 17:38:03.307 plugin-container[1639:7495] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 17:38:03 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:38:03 INFO - PID 1637 | 2017-05-01 17:38:03.307 plugin-container[1639:7495] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:38:03 INFO - PID 1637 | __metrics Screen width/height:1600/1200 17:38:03 INFO - PID 1637 | colorDepth:24 17:38:03 INFO - PID 1637 | Browser inner width/height: 1024/689 17:38:03 INFO - PID 1637 | __metrics 17:38:04 INFO - TEST-INFO | 1637: exit 0 17:38:04 INFO - Browser initialized. 17:38:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:38:04 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpyiMVOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:06 INFO - PID 1640 | 2017-05-01 17:38:06.909 plugin-container[1641:7627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 17:38:06 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:38:06 INFO - PID 1640 | 2017-05-01 17:38:06.910 plugin-container[1641:7627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9717, name = 'com.apple.CFPasteboardClient' 17:38:06 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:38:06 INFO - PID 1640 | 2017-05-01 17:38:06.910 plugin-container[1641:7627] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:38:16 INFO - PID 1640 | RSS: Main: 235237376 17:38:16 INFO - PID 1640 | 17:41:20 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49229/tests/dromaeo/cssquery-ext.html) 17:41:22 INFO - PID 1640 | RSS: Main: 251801600 17:41:22 INFO - PID 1640 | 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 17:43:05 INFO - PID 1640 | 17:43:05 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:43:05 INFO - PID 1640 | Full stack: 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 17:43:05 INFO - PID 1640 | 17:43:05 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:43:05 INFO - PID 1640 | Full stack: 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 17:43:05 INFO - PID 1640 | 17:43:05 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:43:05 INFO - PID 1640 | Full stack: 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | ************************* 17:43:05 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 17:43:05 INFO - PID 1640 | 17:43:05 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:43:05 INFO - PID 1640 | Full stack: 17:43:05 INFO - PID 1640 | ************************* 17:44:24 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-ext.html (next: http://localhost:49229/tests/dromaeo/cssquery-jquery.html) 17:44:25 INFO - PID 1640 | RSS: Main: 257888256 17:44:25 INFO - PID 1640 | 17:47:26 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49229/tests/dromaeo/cssquery-mootools.html) 17:47:27 INFO - PID 1640 | RSS: Main: 268386304 17:47:27 INFO - PID 1640 | 17:50:29 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49229/tests/dromaeo/cssquery-prototype.html) 17:50:29 INFO - PID 1640 | RSS: Main: 260878336 17:50:29 INFO - PID 1640 | 17:53:32 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49229/tests/dromaeo/cssquery-yui.html) 17:53:33 INFO - PID 1640 | RSS: Main: 269983744 17:53:33 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-yui.html (next: http://localhost:49229/tests/dromaeo/cssquery-dojo.html) 17:56:35 INFO - PID 1640 | RSS: Main: 264695808 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | __start_tp_report 17:56:35 INFO - PID 1640 | _x_x_mozilla_page_load 17:56:35 INFO - PID 1640 | _x_x_mozilla_page_load_details 17:56:35 INFO - PID 1640 | |i|pagename|runs| 17:56:35 INFO - PID 1640 | |0;dojo.html;3480.6171321154684;3584.928301433971;3630.364686179918;3649.671529562339;3662.359087159746;6119.0151432184075;6229.470495007924;6243.625382477043;6257.405546473089;6316.873662526747;5865.29616446026;6168.352323006087;6208.1308616793685;6268.84327891803;6283.528735344856;5438.238646589461;5498.257735205736;5510.476504732044;5516.172574113875;5531.2809334786425;5532.446755324456;5627.324721033482;5638.295213098363;5665.603407761459;5685.118806584966;5394.109971854639;5517.834464966058;5537.307836520435;5598.776048958037;5614.971925140389;5431.619786614939;5453.918191227135;5462.180672899097;5475.67145971239;5482.588805839578;5432.864178395532;5454.127339625641;5530.170474428868;5537.667739935617;5538.307711536058;5955.851103722398;6223.598142507623;6249.156363890862;6258.530610204208;6263.87472250557;6666.0667506549125;6731.831704207385;6748.493862960248;6748.7637932672615;6763.492738044617;6539.771108011197;6670.799876003679;6709.664516774142;6765.763198288037;6797.52417330787;6356.396142366468;6375.426211640928;6417.903731444032;6422.678866056725;6425.036244563353;7066.611336376446;7073.009778630996;7085.751998680124;7089.61007144612;7093.432525397956;6423.678816059179;6521.576097553644;6524.184476940382;6620.337966203438;6703.162104736908;5622.240997465372;6699.129113215251;6796.694148763218;6803.149606299213;6847.417969472651;6731.932680673229;6742.898856517156;6757.93242067573;6762.154730658668;6780.220274668476;5852.887951289242;6713.966430167818;6740.764073257511;6793.048973143764;6796.490263230277;5294.49702278283;5344.8663783404945;5361.329833770778;5393;5419.864503387368;4747.691400058985;4797.736124513115;4798.2082956311815;4860.149473842063;4875.536824001714;5153.561947234452;5567.8029223716285;5763.567732420085;6105.572609917352;6344.49244060474;6625.635590042498;6708.932910670928;6834.419074378733;6838.179418469816;6865.485088618374;6378.266499352634;6470.870582588416;6487.870242595121;6488.967555162194;6511.706973186218;6005.189299444519;6092.238470191226;6097.268327800603;6101.328853826076;6116.541259405562;6774.220964589135;6940.167179938439;7020.368166865007;7151.356377926011;7181.533200341961;6838.487113466609;6859.142607174103;6881.690323935335;6891.27641597625;6905.585664860125;7042.119735033121;7091.858162836611;7099.716011359487;7122.038524799293;7125.75059872902;6479.287278399466;6548.8362790930605;6667.266600674019;6710.899336509859;6790.694418751267;6825.795226143224;6839.555428897106;6875.965620171867;6900.482463815133;7049.929500704928;5533.446655334596;6419.45434638061;6618.338166183343;6634.535582509178;6659.267480577036;6309.400606942333;6471.9968404895435;6532.444742196966;6593.736250550116;6605.9009114864275;6352.555321127476;6448.677566121582;6501.122348483083;6518.608883467007;6538.215414150332;6625.469962403093;6648.401643852077;6650;6666;6670.066190733204;6260.968695156495;6321.557490975588;6330.936690633035;6463.773767918288;6465.579737317059 17:56:35 INFO - PID 1640 | |1;ext.html;750;796.4663675337523;817.403295594216;1202.3747651221365;1246.8503779546456;36170.27659446813;36221.73223937166;36235.094122646944;36280;36499.635003649986;36292.63707362926;36681;36737;36776.44835327465;36797;7609.809754756134;7750.651220695054;8083.151269116746;8289.502629842229;8310.376721745863;8176.1415051419635;8200.466969646985;8275.958620206891;8279;8291.83416331673;6941.479389045817;8188;8217.753467395987;8269.29710974568;8310.210529999671;8234;8248.876266856001;8274.503529788202;8280.047794503618;8296.958515207385;8120.106788253287;8194.50832950025;8201.384896132813;8209.220124088202;8210.425270231086;28095.876164953377;32533;34835.12912177216;34906.825465872505;35041.474377884355;3227.9031629051165;3525.8413371398346;3526.7354948378716;3530.3645343838098;3534.628863969272;28999;29027;29043.838246470117;29090;29098.563521547192;3049.4663433898977;3074.446599612069;3076.9538456923165;3095.8142511449387;3107.90676279712;189677;247576.76211618827;278847;297340.5132974343;301913;44998.55001450009;45285.09429811385;45456;45479.545204548194;45504;42330;43980;46861;47851;48026.27960580594;13838.377273022737;13860.584182474542;13950.09324393911;13969.930150349182;13972.650683732785;11528.654140375802;11540.711482213012;11550.306981581132;11561;11568;12997.675058123434;13139.737205255842;13140.145890517086;13165.275909825052;13226.867731322563;5842.912356314659;5887.5289976802605;5902.321233058167;5906.645601263938;5923;966.3380584299778;976.4629453800524;996.2826764729383;1004.8944860789512;1033.6485594897772;23294.3011709649;23454.882725586263;23573;23623.40941476477;23653.290401287988;1087.586717047517;1094.4965315954591;1125.1561329003248;1133.6485689436302;1136.7101389145714;11591.76816463666;12018.875092476019;12052.819207711891;12079.818802717966;12172.330521821385;297860.5320920188;303565.44651830243;322838;324282;326407;50204.49795502071;50430.9827606899;50454.49545504498;50468;50517.747411263445;1476.1143314011508;1505.6010157308103;1549.055076403393;1549.7830303757482;1565.8121025477017;19548.120334585263;21518.784812151676;23490.647640285068;23557.52884942326;23688.644670329613;27754.306142346602;36465.27069458543;36616.45075323819;36633.81683091674;36901.44647830231;227330.72669273097;267698;272159;278140;278144;31796.728130874504;32414.189645259055;32543;33185;33464.1633959153;30783.846080769454;41312.38031429591;42171.57828421799;43697.344539832564;43971.56028439675;26287.474250515264;28840.990565330114;29451.674674640122;30074.090368251986;30346.544801828433;29194.56208156837;29315.413691726473;30174.69825301807;30189.849050754605;30378.240543985692;35767.28465430729;36045.7383991559;36109.27781444409;36211.637883620824;36229.45655815112;28346.858265709365;28468.430631386844;29675.109746707632;29876.850615746782;30225.395492090476;18629.90685046566;20284.290049848183;20862.68705969442;23852.880735596213;23881.880590596935 17:56:35 INFO - PID 1640 | |2;jquery.html;390.7105990740438;430.27069117845264;435.46002956334144;454.14167223946737;455.05802987815235;19250.422487325366;20583.382498525032;21106.366808995717;21303.467413314636;21394.25120120796;21515.569688606218;22630;23422.945967431464;23453.882730586367;23674.28977130689;5421.647592906468;6190.783322583699;6375.649339286338;6396.872062558746;6408;5858.443447872445;6107.480864126533;6110.175126357952;6136.171616831715;6182.69086545671;5957.582969192158;5997.940020599804;6115.235595550556;6120.173776540177;6126.326104128542;6057.909131363033;6139.662318572477;6146.108814221912;6148.38516148386;6150.477209437203;5260.631755777097;5372.489613486751;5454.836354909359;5456.563474921997;5502.9174562381595;27249.591256131174;27649;27655.446891062267;27672.446551068864;27767.166984990483;2206.172685243034;2267.2971378872603;2268.206127855254;2269.965950510744;2274.363178310059;17500.38748643804;17693.469195924143;18136;18148.909255453636;18464.907675461673;1787.9093752810775;2094.979050209494;2153.493928926701;2158.32012915931;2160.459885028743;140204;159218;160640.19679901525;161009;161203;10294.639687610897;12160.209586376857;12740.936295318465;12749.107562470537;12798.040146989013;15677.29452174655;16465.91767041157;16466.09436480981;16473.093979830985;16483;7691;8880.333974951904;8989.730308090768;9072.935515202995;9161.908380916238;8660.913390866011;8669.523176225368;8699.13008699125;8833.33749968755;8853.557322133867;6484.675766211671;7969.760907172794;8088.272055515032;8147.348212143014;8155.755327340189;2165.101482884617;2175.59751445983;2182.6616874384495;2193.6928829963817;2344.9531009379716;938.5354249646332;952.5427794658602;958.8561715742694;968.2641192693462;993.9751506212402;16395;21053.578928421346;21556.137754489646;21659.891700541397;21791.45521361947;888.2849306308484;932.4079209701888;941.2517048946104;982.6658935961807;1007.9143272821746;10115.747106322253;10938.398388088572;11227.045701115496;11238.044766194966;11247.718807029889;503758;527476;530336;551675;556256;131460;132494;140210;140556.48568923076;149648.25175874052;1102.167863263231;1161.6863446869297;1208.1482554799022;1252.9624111276676;1260.7667581497453;17089.91455042717;18467.353642622445;18639.627207456047;22873;23103.884480578163;60601.696991516525;60632.393676062675;61407.38592614017;62443.06335405063;62626;84363.5781821087;85181.57409212914;85838;85860.57069714612;85879;9112.95443522778;9114.088591140833;9172.669962855482;9228.676996305365;9368.531573421165;14416.062955907832;14498.85501144975;14632.70734585281;14738.926305368404;15082.54752357431;9682.612695492102;11685.474153662935;12000.459979300778;12273.570425035081;12467.93766031164;11725.061995040547;11766.470508827295;11862.644120676394;12096.395180241128;12165.33090680021;11558.42207889619;11568.07455403549;11570.826437603611;12777.59173085284;12887.48450061987;8929.508877011827;8973;9057.049009854134;9181.449113052971;9268.212201962908;12126;12183.329916854304;12342.506299747909;12401.813972790596;12433.316167610868 17:56:35 INFO - PID 1640 | |3;mootools.html;1396.588006538071;1429.4282287085164;1451.4194322271085;1461.3789139615667;1466.2155746675523;11244.269122507032;11676.241044332122;11728.648140555797;11769.470373833177;11847.407629618529;11605.071594272458;11623.01204397625;11784.292942423439;11792.410379481013;11826.94086529566;2130.28635407138;2235.2400183937457;2496.213692686807;2553.48930213957;2553.6297236900637;1972.6942323939813;2465.9753402466013;2526.103233352161;2526.987365063172;2533.4679717259396;2418.419579300964;2429.283361408389;2472.4807790363957;2475.7029156501153;2479.3181874984434;2421.4793819328843;2449.4243852694603;2484.8012159027326;2486.2292689266205;2491.451880586268;2076.439361372436;2422.2369953464604;2459.2499287717237;2482.1064416809936;2528.3679080229945;11536.769264614744;11606.94196529012;11698.883011169864;11709;11715.882841171564;6424.486041116699;6605.801825945229;6671.733130674767;6686.431653309426;6688.030235615857;4014.4781178446906;4292.806823692941;4382.211201983641;4395.450568678915;4403.581659742352;1262.0912942681255;1266.5877546535546;1304.3347892574855;1313.0349193342886;1317.9670508237275;15208.847911520854;15658.68682626341;15780.526584202493;15785.842141578438;15797.763033554505;5550.750216240198;5620.4098569649595;5700.97149514258;5792.478676919013;5808.39011903744;11932.105092118127;11932.880671193177;11982.58060967862;12008.699782505333;12021.819672704916;6558.80323590293;6591.176102987127;6605.141331626858;6606.042123892009;6626.9337306627285;5971.880562388728;6194.132821405007;6210.068489726577;6230.968845155836;6234.376562343729;4032.052467670095;4248.851290204828;4362.672799539983;4372.912541749147;4415.580519850609;1140.1733743036232;1279.05350040969;1282.6665067082627;1286.01619760883;1287.7875150600235;685.2291172431015;796.7729197178776;805.8549461097059;816.9591520423955;822.4201937633953;6467.870642587122;6937.271586483447;6951.6871740771785;7150.356467917808;7278.454115941326;798.4730078148394;926.1849572376266;930.3766476460787;938.5588773276686;955.7992821507422;4252.29837076885;4294.7852607369505;4357.694961352675;4431.778411079433;4454.374153434038;13652.249126297951;13988.650283742987;14035.298235088205;14067.155970641794;14091.85908140926;13851.376688049062;13913.443462261395;13933.58199254024;14076.014678972579;14470.421183152555;7446.962765186247;8377.832443351099;8590.441621294722;8595.613197406132;8600.010998735226;5731.828045158652;6251.218597675291;6522.510811689048;6889.586624802528;6961;12725.80911286313;12926.224426534438;13128.015398844935;13322.733545329233;13427.19436833793;13113.868861311264;13269.800952985519;13279.734405312032;13565.796513052115;13571;9212.631494740403;9228.446293222429;9283.303752218475;9338.859917101114;9402.95298523503;8808.427452215585;10561.419121948367;10635.8936410638;10647.72227332725;10662.200334974752;8793.736187914374;9067.04795996411;9121.589528471368;9141;9193.724188274362;8799.736007919773;8826.823463530565;8858.689945851864;8927.241184499131;9048.864267036131;6712.328767123248;6935.549189302679;7996.280334769898;8048.5975701215875;8065.314448271963;5134.743262836918;5298.708571028476;5914;5959.195508606283;6077.20996270482;6039.758409663565;6066.605670631395;6227.159333489921;6262.123302737529;6360.014197799349 17:56:35 INFO - PID 1640 | |4;prototype.html;404.9814715989286;405.21792939626516;406.59949949299937;407.76553481747993;415.22767652166965;5233.712145831978;5275.419703832576;5434.375046869611;6316.968415157923;6335.909149980507;4666.743329116897;5273.446288139738;6072.908906366408;6130.386961303868;6296.401841825019;4158.334666453368;4388.736675799446;4405.185040767468;4717.056588682261;4751.762411879392;4245.554216807222;4445.22208613493;4447.822087116511;4452.265376212921;4452.441645424108;3827.8086095695244;4414.845480408187;4432.667549933752;4440.86677399677;4446.844360447385;4389.802458889326;4393.923488745246;4427.070315233788;4438.42300500936;4461.709988850746;3441.7590768646205;3768.2651882882847;3773.3962565989586;3793.943090853639;3800.6769424598942;5983.1623572699855;6003.8198854034445;6003.969980150071;6008.188894499231;6021.548383871227;5167.250748641463;5219.739013049332;5253.343332083489;5270.604704647167;5308.5487733542695;6529.233659428596;6549.476041916635;6553.508486863504;6553.770618028394;6587.50593705474;3384.627690953993;4304.268274393361;4306.074194048263;4309.224339618867;4352.194843953847;6438.871222575569;6870;6955.304469553055;7013.789586312419;7122.290650243956;4340;4355.499117601516;4368.410264614236;4377.78111094444;4379.386885835986;3717.498137751423;4054.432379466877;4141.047559061432;4428.33574963758;4464.776761161929;4839.201531747292;4876.756162191876;5059;5295.279034313787;5309;6569.146011018537;6678.4991125665765;6679;6683.598984060972;6717.6977036033495;1504.8645621894082;1519.2555647732531;1522.9771553426708;1524.7941527893593;1525.22311507093;806.26629766913;964.5514835601479;979.0894468144552;985.605757696927;1002.6791426743372;5612.635178713453;6053.818385448443;6339.96830015847;6350.587211831308;6362.681865906686;5200.843974680765;6249.5626705584855;6568.047633093175;6941.722331106699;6943.305669433016;4765.309030190603;5510.91733623988;6187.752489900444;6272.498200143978;6381.489480841522;2948.8673009714616;3612.6387361263664;3614.6566076222716;3622.492851000862;3624.8187590620364;6316.9368306317265;6875.69966416123;6904.378605925491;6942.618156001468;7166.175889772639;5865.296164460292;6634;7132.17979932304;7145.6784444700115;7182.640867956581;6771.492138089663;7120.520326502961;7157.6779044943105;7196.964015179995;7209.927900720925;5314.8937021260135;5870.53035757147;5953.672548009901;6069.696515174312;6904.4131248844415;6203.906941395973;6738.629375384205;6800.777288780908;6862.176538815374;6884.208316043719;6803;6997.755078572225;7244.927550724426;7248.311410416002;7281.927180728337;4966.478519755374;4968.857162852636;4995.400551933646;4998.225275082368;5040.57155141817;5891.410858914074;6048.667323297085;6705.463562914858;6896.413804826646;6967.686454109678;5858.179854820414;6670.966645166744;6676.866462670817;6760;6766.898496522655;6301.495880329654;6529.444997175104;6643.534952553468;6728.966355168192;6734.3602357775935;6452.677366131581;6480.805575832733;6497.610143391223;6497.642629655415;6510.112067500372;6455.966370593248;6612.801615951529;6658.966705166443;6662.766803161866;6700.061991321121;5206.167013277857;5330.733463326896;5611.438856114356;6467.708953097216;6531.738730450728 17:56:35 INFO - PID 1640 | |5;yui.html;816.1552792859392;817.52992029583;826.107803572142;855.0210009539078;861.9870701939471;15884.682306353867;16448.91775541122;16864.494065178034;16901.070441125732;18278.817211827878;17752.556186095353;18027;18092;18145.54636134094;18322.35871744489;983.1888691829251;991.0436428846162;998.3710262534593;1000.194843151263;1004.6483730694272;1004.8643433136542;1016.8678071850649;1020.6427750287414;1022.5858527296419;1023.9283250172491;1046.6650671785033;1052.273930987616;1056.4453661827563;1056.9958539387574;1057.2863317260856;1035.3994683083793;1042.249580302185;1057.984130238047;1058.539535302146;1058.8623478947688;753.5365750063671;770.1874522378888;773.3581127664025;783.2989474420361;788.5820515126992;16411.015339079695;16637.918535295168;16767.83232167687;16775.32898684051;16776.245068971926;17150.82849171505;17185.570360740956;17535.386261480915;17631.5592110197;17792.288308467647;13987.860121398859;14050.43798248069;14147.787783183261;14252.572422827332;14285.285735713172;3426.5716785401823;3486.9651303486894;3487.7907325560545;3490.0925759302763;3494.637091534278;115700.42149789198;131985.34007329997;133773.33113334468;135158;137729;13146.737065258641;13347.399367028313;13367.398467069006;13523.797143042862;13544.796828047587;23921;24158.79206039726;25741.485170296488;25908.740912590634;26401.735982639926;7492.026036615205;7526.811829704301;7531.548107113591;7562.584057876759;7613.9238607613215;3736.551613806361;3783.1866148778145;3814.504114465102;3818.3317919364;3819.2934307153264;3936.173403585222;4114.629683328515;4372.0818628088455;4380.518143004267;4392.3411488277015;779.9376049915993;896.1844721303713;902.634433054614;910.1399177776938;911.4030310146865;646.7251418147268;653.6176336842905;655.8393193667582;666.8366250268715;683.987698206647;10968.670939871816;11654.951054405145;11790.351530665896;11826.231294965972;13459.865401346056;648.7178077536192;656.9408753212139;658.3449467779494;681.0703389872887;683.6786710246176;5201.557867581222;5218.347706536683;5281.207818827206;5436.972815135899;5556.861078473071;108573.45713271383;110903;110923.44538277257;110962;113610.43194783974;95850;96857.06285874384;97738.51130744301;98663.52004719934;99148.5042574797;85112.57443712742;85316.333583623;86324.56837715897;86564;87294;9870.851937220803;10761.085307748615;10999.120070394189;11127.1654625905;11226.382548959886;41846.37230441485;42149;43202.567974319856;43284.78357608192;43505.56494435015;55088.72455637696;55394.72302638461;55856;56267.718661406434;56599.30202093944;14010.859891400956;14061.367238474499;14094.859051409765;14419.42322307096;14480.927595361956;15516.689666206386;15588.844111559192;15706.685866282382;15740.68518629644;15772.132532710812;14071.437142514185;14110.130273385052;14433.78349324782;14775.408983640535;14795.482158124414;11939;14290.57128286153;14517.564473065824;14562.563123106323;14572.927135364256;11273.605423810455;13874.098183618033;14003.649908752363;14485.420583176556;14493.057951233137;10478.947605261925;10531.315464494783;10661.307015044307;10775.6228532001;10782.568697252022;10886.61896833607;10933.945330273298;11273.549058037586;11687.590934317259;11888.643340699447 17:56:35 INFO - PID 1640 | __end_tp_report 17:56:35 INFO - PID 1640 | __start_cc_report 17:56:35 INFO - PID 1640 | _x_x_mozilla_cycle_collect,409 17:56:35 INFO - PID 1640 | __end_cc_report 17:56:35 INFO - PID 1640 | __startTimestamp1493686595259__endTimestamp 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | ------- Summary: start ------- 17:56:35 INFO - PID 1640 | Number of tests: 6 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6222.50 Median:6463.77 stddev:744.71 (11.5%) stddev-sans-first:715.25 17:56:35 INFO - PID 1640 | Values: 3480.6 3584.9 3630.4 3649.7 3662.4 6119.0 6229.5 6243.6 6257.4 6316.9 5865.3 6168.4 6208.1 6268.8 6283.5 5438.2 5498.3 5510.5 5516.2 5531.3 5532.4 5627.3 5638.3 5665.6 5685.1 5394.1 5517.8 5537.3 5598.8 5615.0 5431.6 5453.9 5462.2 5475.7 5482.6 5432.9 5454.1 5530.2 5537.7 5538.3 5955.9 6223.6 6249.2 6258.5 6263.9 6666.1 6731.8 6748.5 6748.8 6763.5 6539.8 6670.8 6709.7 6765.8 6797.5 6356.4 6375.4 6417.9 6422.7 6425.0 7066.6 7073.0 7085.8 7089.6 7093.4 6423.7 6521.6 6524.2 6620.3 6703.2 5622.2 6699.1 6796.7 6803.1 6847.4 6731.9 6742.9 6757.9 6762.2 6780.2 5852.9 6714.0 6740.8 6793.0 6796.5 5294.5 5344.9 5361.3 5393.0 5419.9 4747.7 4797.7 4798.2 4860.1 4875.5 5153.6 5567.8 5763.6 6105.6 6344.5 6625.6 6708.9 6834.4 6838.2 6865.5 6378.3 6470.9 6487.9 6489.0 6511.7 6005.2 6092.2 6097.3 6101.3 6116.5 6774.2 6940.2 7020.4 7151.4 7181.5 6838.5 6859.1 6881.7 6891.3 6905.6 7042.1 7091.9 7099.7 7122.0 7125.8 6479.3 6548.8 6667.3 6710.9 6790.7 6825.8 6839.6 6876.0 6900.5 7049.9 5533.4 6419.5 6618.3 6634.5 6659.3 6309.4 6472.0 6532.4 6593.7 6605.9 6352.6 6448.7 6501.1 6518.6 6538.2 6625.5 6648.4 6650.0 6666.0 6670.1 6261.0 6321.6 6330.9 6463.8 6465.6 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:42424.66 Median:163032.95 stddev:74298.40 (45.6%) stddev-sans-first:74440.94 17:56:35 INFO - PID 1640 | Values: 750.0 796.5 817.4 1202.4 1246.9 36170.3 36221.7 36235.1 36280.0 36499.6 36292.6 36681.0 36737.0 36776.4 36797.0 7609.8 7750.7 8083.2 8289.5 8310.4 8176.1 8200.5 8276.0 8279.0 8291.8 6941.5 8188.0 8217.8 8269.3 8310.2 8234.0 8248.9 8274.5 8280.0 8297.0 8120.1 8194.5 8201.4 8209.2 8210.4 28095.9 32533.0 34835.1 34906.8 35041.5 3227.9 3525.8 3526.7 3530.4 3534.6 28999.0 29027.0 29043.8 29090.0 29098.6 3049.5 3074.4 3077.0 3095.8 3107.9 189677.0 247576.8 278847.0 297340.5 301913.0 44998.6 45285.1 45456.0 45479.5 45504.0 42330.0 43980.0 46861.0 47851.0 48026.3 13838.4 13860.6 13950.1 13969.9 13972.7 11528.7 11540.7 11550.3 11561.0 11568.0 12997.7 13139.7 13140.1 13165.3 13226.9 5842.9 5887.5 5902.3 5906.6 5923.0 966.3 976.5 996.3 1004.9 1033.6 23294.3 23454.9 23573.0 23623.4 23653.3 1087.6 1094.5 1125.2 1133.6 1136.7 11591.8 12018.9 12052.8 12079.8 12172.3 297860.5 303565.4 322838.0 324282.0 326407.0 50204.5 50431.0 50454.5 50468.0 50517.7 1476.1 1505.6 1549.1 1549.8 1565.8 19548.1 21518.8 23490.6 23557.5 23688.6 27754.3 36465.3 36616.5 36633.8 36901.4 227330.7 267698.0 272159.0 278140.0 278144.0 31796.7 32414.2 32543.0 33185.0 33464.2 30783.8 41312.4 42171.6 43697.3 43971.6 26287.5 28841.0 29451.7 30074.1 30346.5 29194.6 29315.4 30174.7 30189.8 30378.2 35767.3 36045.7 36109.3 36211.6 36229.5 28346.9 28468.4 29675.1 29876.9 30225.4 18629.9 20284.3 20862.7 23852.9 23881.9 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:35873.76 Median:23263.42 stddev:91360.49 (392.7%) stddev-sans-first:91577.94 17:56:35 INFO - PID 1640 | Values: 390.7 430.3 435.5 454.1 455.1 19250.4 20583.4 21106.4 21303.5 21394.3 21515.6 22630.0 23422.9 23453.9 23674.3 5421.6 6190.8 6375.6 6396.9 6408.0 5858.4 6107.5 6110.2 6136.2 6182.7 5957.6 5997.9 6115.2 6120.2 6126.3 6057.9 6139.7 6146.1 6148.4 6150.5 5260.6 5372.5 5454.8 5456.6 5502.9 27249.6 27649.0 27655.4 27672.4 27767.2 2206.2 2267.3 2268.2 2270.0 2274.4 17500.4 17693.5 18136.0 18148.9 18464.9 1787.9 2095.0 2153.5 2158.3 2160.5 140204.0 159218.0 160640.2 161009.0 161203.0 10294.6 12160.2 12740.9 12749.1 12798.0 15677.3 16465.9 16466.1 16473.1 16483.0 7691.0 8880.3 8989.7 9072.9 9161.9 8660.9 8669.5 8699.1 8833.3 8853.6 6484.7 7969.8 8088.3 8147.3 8155.8 2165.1 2175.6 2182.7 2193.7 2345.0 938.5 952.5 958.9 968.3 994.0 16395.0 21053.6 21556.1 21659.9 21791.5 888.3 932.4 941.3 982.7 1007.9 10115.7 10938.4 11227.0 11238.0 11247.7 503758.0 527476.0 530336.0 551675.0 556256.0 131460.0 132494.0 140210.0 140556.5 149648.3 1102.2 1161.7 1208.1 1253.0 1260.8 17089.9 18467.4 18639.6 22873.0 23103.9 60601.7 60632.4 61407.4 62443.1 62626.0 84363.6 85181.6 85838.0 85860.6 85879.0 9113.0 9114.1 9172.7 9228.7 9368.5 14416.1 14498.9 14632.7 14738.9 15082.5 9682.6 11685.5 12000.5 12273.6 12467.9 11725.1 11766.5 11862.6 12096.4 12165.3 11558.4 11568.1 11570.8 12777.6 12887.5 8929.5 8973.0 9057.0 9181.4 9268.2 12126.0 12183.3 12342.5 12401.8 12433.3 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:6989.88 Median:4140.45 stddev:4335.56 (104.7%) stddev-sans-first:4327.35 17:56:35 INFO - PID 1640 | Values: 1396.6 1429.4 1451.4 1461.4 1466.2 11244.3 11676.2 11728.6 11769.5 11847.4 11605.1 11623.0 11784.3 11792.4 11826.9 2130.3 2235.2 2496.2 2553.5 2553.6 1972.7 2466.0 2526.1 2527.0 2533.5 2418.4 2429.3 2472.5 2475.7 2479.3 2421.5 2449.4 2484.8 2486.2 2491.5 2076.4 2422.2 2459.2 2482.1 2528.4 11536.8 11606.9 11698.9 11709.0 11715.9 6424.5 6605.8 6671.7 6686.4 6688.0 4014.5 4292.8 4382.2 4395.5 4403.6 1262.1 1266.6 1304.3 1313.0 1318.0 15208.8 15658.7 15780.5 15785.8 15797.8 5550.8 5620.4 5701.0 5792.5 5808.4 11932.1 11932.9 11982.6 12008.7 12021.8 6558.8 6591.2 6605.1 6606.0 6626.9 5971.9 6194.1 6210.1 6231.0 6234.4 4032.1 4248.9 4362.7 4372.9 4415.6 1140.2 1279.1 1282.7 1286.0 1287.8 685.2 796.8 805.9 817.0 822.4 6467.9 6937.3 6951.7 7150.4 7278.5 798.5 926.2 930.4 938.6 955.8 4252.3 4294.8 4357.7 4431.8 4454.4 13652.2 13988.7 14035.3 14067.2 14091.9 13851.4 13913.4 13933.6 14076.0 14470.4 7447.0 8377.8 8590.4 8595.6 8600.0 5731.8 6251.2 6522.5 6889.6 6961.0 12725.8 12926.2 13128.0 13322.7 13427.2 13113.9 13269.8 13279.7 13565.8 13571.0 9212.6 9228.4 9283.3 9338.9 9403.0 8808.4 10561.4 10635.9 10647.7 10662.2 8793.7 9067.0 9121.6 9141.0 9193.7 8799.7 8826.8 8858.7 8927.2 9048.9 6712.3 6935.5 7996.3 8048.6 8065.3 5134.7 5298.7 5914.0 5959.2 6077.2 6039.8 6066.6 6227.2 6262.1 6360.0 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5296.25 Median:6003.89 stddev:1703.33 (28.4%) stddev-sans-first:1668.08 17:56:35 INFO - PID 1640 | Values: 405.0 405.2 406.6 407.8 415.2 5233.7 5275.4 5434.4 6317.0 6335.9 4666.7 5273.4 6072.9 6130.4 6296.4 4158.3 4388.7 4405.2 4717.1 4751.8 4245.6 4445.2 4447.8 4452.3 4452.4 3827.8 4414.8 4432.7 4440.9 4446.8 4389.8 4393.9 4427.1 4438.4 4461.7 3441.8 3768.3 3773.4 3793.9 3800.7 5983.2 6003.8 6004.0 6008.2 6021.5 5167.3 5219.7 5253.3 5270.6 5308.5 6529.2 6549.5 6553.5 6553.8 6587.5 3384.6 4304.3 4306.1 4309.2 4352.2 6438.9 6870.0 6955.3 7013.8 7122.3 4340.0 4355.5 4368.4 4377.8 4379.4 3717.5 4054.4 4141.0 4428.3 4464.8 4839.2 4876.8 5059.0 5295.3 5309.0 6569.1 6678.5 6679.0 6683.6 6717.7 1504.9 1519.3 1523.0 1524.8 1525.2 806.3 964.6 979.1 985.6 1002.7 5612.6 6053.8 6340.0 6350.6 6362.7 5200.8 6249.6 6568.0 6941.7 6943.3 4765.3 5510.9 6187.8 6272.5 6381.5 2948.9 3612.6 3614.7 3622.5 3624.8 6316.9 6875.7 6904.4 6942.6 7166.2 5865.3 6634.0 7132.2 7145.7 7182.6 6771.5 7120.5 7157.7 7197.0 7209.9 5314.9 5870.5 5953.7 6069.7 6904.4 6203.9 6738.6 6800.8 6862.2 6884.2 6803.0 6997.8 7244.9 7248.3 7281.9 4966.5 4968.9 4995.4 4998.2 5040.6 5891.4 6048.7 6705.5 6896.4 6967.7 5858.2 6671.0 6676.9 6760.0 6766.9 6301.5 6529.4 6643.5 6729.0 6734.4 6452.7 6480.8 6497.6 6497.6 6510.1 6456.0 6612.8 6659.0 6662.8 6700.1 5206.2 5330.7 5611.4 6467.7 6531.7 17:56:35 INFO - PID 1640 | 17:56:35 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:22085.40 Median:17168.20 stddev:32471.00 (189.1%) stddev-sans-first:32522.82 17:56:35 INFO - PID 1640 | Values: 816.2 817.5 826.1 855.0 862.0 15884.7 16448.9 16864.5 16901.1 18278.8 17752.6 18027.0 18092.0 18145.5 18322.4 983.2 991.0 998.4 1000.2 1004.6 1004.9 1016.9 1020.6 1022.6 1023.9 1046.7 1052.3 1056.4 1057.0 1057.3 1035.4 1042.2 1058.0 1058.5 1058.9 753.5 770.2 773.4 783.3 788.6 16411.0 16637.9 16767.8 16775.3 16776.2 17150.8 17185.6 17535.4 17631.6 17792.3 13987.9 14050.4 14147.8 14252.6 14285.3 3426.6 3487.0 3487.8 3490.1 3494.6 115700.4 131985.3 133773.3 135158.0 137729.0 13146.7 13347.4 13367.4 13523.8 13544.8 23921.0 24158.8 25741.5 25908.7 26401.7 7492.0 7526.8 7531.5 7562.6 7613.9 3736.6 3783.2 3814.5 3818.3 3819.3 3936.2 4114.6 4372.1 4380.5 4392.3 779.9 896.2 902.6 910.1 911.4 646.7 653.6 655.8 666.8 684.0 10968.7 11655.0 11790.4 11826.2 13459.9 648.7 656.9 658.3 681.1 683.7 5201.6 5218.3 5281.2 5437.0 5556.9 108573.5 110903.0 110923.4 110962.0 113610.4 95850.0 96857.1 97738.5 98663.5 99148.5 85112.6 85316.3 86324.6 86564.0 87294.0 9870.9 10761.1 10999.1 11127.2 11226.4 41846.4 42149.0 43202.6 43284.8 43505.6 55088.7 55394.7 55856.0 56267.7 56599.3 14010.9 14061.4 14094.9 14419.4 14480.9 15516.7 15588.8 15706.7 15740.7 15772.1 14071.4 14110.1 14433.8 14775.4 14795.5 11939.0 14290.6 14517.6 14562.6 14572.9 11273.6 13874.1 14003.6 14485.4 14493.1 10478.9 10531.3 10661.3 10775.6 10782.6 10886.6 10933.9 11273.5 11687.6 11888.6 17:56:35 INFO - PID 1640 | -------- Summary: end -------- 17:56:35 INFO - PID 1640 | 17:56:35 INFO - TEST-INFO | 1640: exit 0 17:56:35 INFO - TEST-OK | dromaeo_css | took 1115620ms 17:56:35 INFO - TEST-START | kraken 17:56:35 INFO - operating with platform_type : mac_ 17:56:35 INFO - Initialising browser for kraken test... 17:56:35 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpQDJNdc/profile http://localhost:49229/getInfo.html) 17:56:38 INFO - PID 1654 | 2017-05-01 17:56:38.650 plugin-container[1655:10141] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.tsm.portname' 17:56:38 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:38 INFO - PID 1654 | 2017-05-01 17:56:38.655 plugin-container[1655:10141] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 17:56:38 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:38 INFO - PID 1654 | 2017-05-01 17:56:38.655 plugin-container[1655:10141] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:56:38 INFO - PID 1654 | __metrics Screen width/height:1600/1200 17:56:38 INFO - PID 1654 | colorDepth:24 17:56:38 INFO - PID 1654 | Browser inner width/height: 1024/689 17:56:38 INFO - PID 1654 | __metrics 17:56:39 INFO - TEST-INFO | 1654: exit 0 17:56:39 INFO - Browser initialized. 17:56:39 INFO - Running cycle 1/1 for kraken test... 17:56:39 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpQDJNdc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:42 INFO - PID 1656 | 2017-05-01 17:56:42.340 plugin-container[1657:10265] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454f, name = 'com.apple.tsm.portname' 17:56:42 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:42 INFO - PID 1656 | 2017-05-01 17:56:42.341 plugin-container[1657:10265] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 17:56:42 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:56:42 INFO - PID 1656 | 2017-05-01 17:56:42.341 plugin-container[1657:10265] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:56:52 INFO - PID 1656 | RSS: Main: 252379136 17:56:52 INFO - PID 1656 | 17:56:54 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:55 INFO - PID 1656 | RSS: Main: 260669440 17:56:55 INFO - PID 1656 | 17:56:58 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-dft) 17:56:59 INFO - PID 1656 | RSS: Main: 267296768 17:56:59 INFO - PID 1656 | 17:57:02 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-fft) 17:57:03 INFO - PID 1656 | RSS: Main: 262451200 17:57:03 INFO - PID 1656 | 17:57:05 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator) 17:57:05 INFO - PID 1656 | RSS: Main: 263495680 17:57:05 INFO - PID 1656 | 17:57:07 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:57:08 INFO - PID 1656 | RSS: Main: 265318400 17:57:08 INFO - PID 1656 | 17:57:11 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom) 17:57:11 INFO - PID 1656 | RSS: Main: 270381056 17:57:11 INFO - PID 1656 | 17:57:15 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate) 17:57:15 INFO - PID 1656 | RSS: Main: 270921728 17:57:15 INFO - PID 1656 | 17:57:18 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial) 17:57:19 INFO - PID 1656 | RSS: Main: 271163392 17:57:19 INFO - PID 1656 | 17:57:20 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:57:21 INFO - PID 1656 | RSS: Main: 270475264 17:57:21 INFO - PID 1656 | 17:57:23 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:57:24 INFO - PID 1656 | RSS: Main: 270606336 17:57:24 INFO - PID 1656 | 17:57:26 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:57:26 INFO - PID 1656 | RSS: Main: 270278656 17:57:26 INFO - PID 1656 | 17:57:29 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:57:30 INFO - PID 1656 | RSS: Main: 270315520 17:57:30 INFO - PID 1656 | 17:57:33 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:57:34 INFO - PID 1656 | RSS: Main: 271159296 17:57:34 INFO - PID 1656 | 17:57:35 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49229/tests/kraken/driver.html?testName=ai-astar) 17:57:36 INFO - PID 1656 | RSS: Main: 272343040 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | __start_tp_report 17:57:36 INFO - PID 1656 | _x_x_mozilla_page_load 17:57:36 INFO - PID 1656 | _x_x_mozilla_page_load_details 17:57:36 INFO - PID 1656 | |i|pagename|runs| 17:57:36 INFO - PID 1656 | |0;ai-astar;104;124;171;123;117;115;114;117;116;116 17:57:36 INFO - PID 1656 | |1;audio-beat-detection;147;109;114;151;111;116;156;95;138;161 17:57:36 INFO - PID 1656 | |2;audio-dft;202;204;201;229;210;221;197;197;236;278 17:57:36 INFO - PID 1656 | |3;audio-fft;80;58;88;116;65;59;58;59;78;69 17:57:36 INFO - PID 1656 | |4;audio-oscillator;87;67;82;72;69;76;79;71;110;114 17:57:36 INFO - PID 1656 | |5;imaging-gaussian-blur;90;91;90;94;91;91;91;94;134;140 17:57:36 INFO - PID 1656 | |6;imaging-darkroom;101;99;99;96;100;98;98;137;102;149 17:57:36 INFO - PID 1656 | |7;imaging-desaturate;91;86;93;82;141;142;97;141;92;142 17:57:36 INFO - PID 1656 | |8;json-parse-financial;52;51;48;49;49;51;51;47;50;50 17:57:36 INFO - PID 1656 | |9;json-stringify-tinderbox;58;64;62;60;65;61;56;59;60;58 17:57:36 INFO - PID 1656 | |10;stanford-crypto-aes;82;83;82;85;84;82;83;83;82;80 17:57:36 INFO - PID 1656 | |11;stanford-crypto-ccm;162;162;173;152;154;152;153;155;224;159 17:57:36 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;220;188;182;189;189;176;182;187;221;237 17:57:36 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;66;70;69;64;65;64;66;69;68;72 17:57:36 INFO - PID 1656 | __end_tp_report 17:57:36 INFO - PID 1656 | __start_cc_report 17:57:36 INFO - PID 1656 | _x_x_mozilla_cycle_collect,980 17:57:36 INFO - PID 1656 | __end_cc_report 17:57:36 INFO - PID 1656 | __startTimestamp1493686656214__endTimestamp 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | ------- Summary: start ------- 17:57:36 INFO - PID 1656 | Number of tests: 14 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:121.70 Median:117.00 stddev:18.15 (15.5%) stddev-sans-first:18.08 17:57:36 INFO - PID 1656 | Values: 104.0 124.0 171.0 123.0 117.0 115.0 114.0 117.0 116.0 116.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:149.00 stddev:23.36 (15.7%) stddev-sans-first:23.93 17:57:36 INFO - PID 1656 | Values: 147.0 109.0 114.0 151.0 111.0 116.0 156.0 95.0 138.0 161.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:217.50 Median:215.50 stddev:25.25 (11.7%) stddev-sans-first:26.15 17:57:36 INFO - PID 1656 | Values: 202.0 204.0 201.0 229.0 210.0 221.0 197.0 197.0 236.0 278.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:73.00 Median:67.00 stddev:18.47 (27.6%) stddev-sans-first:19.42 17:57:36 INFO - PID 1656 | Values: 80.0 58.0 88.0 116.0 65.0 59.0 58.0 59.0 78.0 69.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:74.00 stddev:16.63 (22.5%) stddev-sans-first:17.56 17:57:36 INFO - PID 1656 | Values: 87.0 67.0 82.0 72.0 69.0 76.0 79.0 71.0 110.0 114.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:91.00 stddev:19.29 (21.2%) stddev-sans-first:20.07 17:57:36 INFO - PID 1656 | Values: 90.0 91.0 90.0 94.0 91.0 91.0 91.0 94.0 134.0 140.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:107.90 Median:97.00 stddev:18.79 (19.4%) stddev-sans-first:19.76 17:57:36 INFO - PID 1656 | Values: 101.0 99.0 99.0 96.0 100.0 98.0 98.0 137.0 102.0 149.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:110.70 Median:88.50 stddev:26.81 (30.3%) stddev-sans-first:27.47 17:57:36 INFO - PID 1656 | Values: 91.0 86.0 93.0 82.0 141.0 142.0 97.0 141.0 92.0 142.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.50 stddev:1.55 (3.1%) stddev-sans-first:1.42 17:57:36 INFO - PID 1656 | Values: 52.0 51.0 48.0 49.0 49.0 51.0 51.0 47.0 50.0 50.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:2.79 (4.6%) stddev-sans-first:2.83 17:57:36 INFO - PID 1656 | Values: 58.0 64.0 62.0 60.0 65.0 61.0 56.0 59.0 60.0 58.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 17:57:36 INFO - PID 1656 | Values: 82.0 83.0 82.0 85.0 84.0 82.0 83.0 83.0 82.0 80.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:164.60 Median:160.50 stddev:21.86 (13.6%) stddev-sans-first:23.16 17:57:36 INFO - PID 1656 | Values: 162.0 162.0 173.0 152.0 154.0 152.0 153.0 155.0 224.0 159.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.10 Median:189.00 stddev:20.83 (11.0%) stddev-sans-first:20.38 17:57:36 INFO - PID 1656 | Values: 220.0 188.0 182.0 189.0 189.0 176.0 182.0 187.0 221.0 237.0 17:57:36 INFO - PID 1656 | 17:57:36 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.50 stddev:2.71 (4.0%) stddev-sans-first:2.83 17:57:36 INFO - PID 1656 | Values: 66.0 70.0 69.0 64.0 65.0 64.0 66.0 69.0 68.0 72.0 17:57:36 INFO - PID 1656 | -------- Summary: end -------- 17:57:36 INFO - PID 1656 | 17:57:37 INFO - TEST-INFO | 1656: exit 0 17:57:37 INFO - TEST-OK | kraken | took 61378ms 17:57:37 INFO - SUITE-END | took 1176s 17:57:37 INFO - Completed test suite (00:19:37) 17:57:37 INFO - javascript benchmark 17:57:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7812.427156393668, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3480.6171321154684, 3584.928301433971, 3630.364686179918, 3649.671529562339, 3662.359087159746, 6119.0151432184075, 6229.470495007924, 6243.625382477043, 6257.405546473089, 6316.873662526747, 5865.29616446026, 6168.352323006087, 6208.1308616793685, 6268.84327891803, 6283.528735344856, 5438.238646589461, 5498.257735205736, 5510.476504732044, 5516.172574113875, 5531.2809334786425, 5532.446755324456, 5627.324721033482, 5638.295213098363, 5665.603407761459, 5685.118806584966, 5394.109971854639, 5517.834464966058, 5537.307836520435, 5598.776048958037, 5614.971925140389, 5431.619786614939, 5453.918191227135, 5462.180672899097, 5475.67145971239, 5482.588805839578, 5432.864178395532, 5454.127339625641, 5530.170474428868, 5537.667739935617, 5538.307711536058, 5955.851103722398, 6223.598142507623, 6249.156363890862, 6258.530610204208, 6263.87472250557, 6666.0667506549125, 6731.831704207385, 6748.493862960248, 6748.7637932672615, 6763.492738044617, 6539.771108011197, 6670.799876003679, 6709.664516774142, 6765.763198288037, 6797.52417330787, 6356.396142366468, 6375.426211640928, 6417.903731444032, 6422.678866056725, 6425.036244563353, 7066.611336376446, 7073.009778630996, 7085.751998680124, 7089.61007144612, 7093.432525397956, 6423.678816059179, 6521.576097553644, 6524.184476940382, 6620.337966203438, 6703.162104736908, 5622.240997465372, 6699.129113215251, 6796.694148763218, 6803.149606299213, 6847.417969472651, 6731.932680673229, 6742.898856517156, 6757.93242067573, 6762.154730658668, 6780.220274668476, 5852.887951289242, 6713.966430167818, 6740.764073257511, 6793.048973143764, 6796.490263230277, 5294.49702278283, 5344.8663783404945, 5361.329833770778, 5393.0, 5419.864503387368, 4747.691400058985, 4797.736124513115, 4798.2082956311815, 4860.149473842063, 4875.536824001714, 5153.561947234452, 5567.8029223716285, 5763.567732420085, 6105.572609917352, 6344.49244060474, 6625.635590042498, 6708.932910670928, 6834.419074378733, 6838.179418469816, 6865.485088618374, 6378.266499352634, 6470.870582588416, 6487.870242595121, 6488.967555162194, 6511.706973186218, 6005.189299444519, 6092.238470191226, 6097.268327800603, 6101.328853826076, 6116.541259405562, 6774.220964589135, 6940.167179938439, 7020.368166865007, 7151.356377926011, 7181.533200341961, 6838.487113466609, 6859.142607174103, 6881.690323935335, 6891.27641597625, 6905.585664860125, 7042.119735033121, 7091.858162836611, 7099.716011359487, 7122.038524799293, 7125.75059872902, 6479.287278399466, 6548.8362790930605, 6667.266600674019, 6710.899336509859, 6790.694418751267, 6825.795226143224, 6839.555428897106, 6875.965620171867, 6900.482463815133, 7049.929500704928, 5533.446655334596, 6419.45434638061, 6618.338166183343, 6634.535582509178, 6659.267480577036, 6309.400606942333, 6471.9968404895435, 6532.444742196966, 6593.736250550116, 6605.9009114864275, 6352.555321127476, 6448.677566121582, 6501.122348483083, 6518.608883467007, 6538.215414150332, 6625.469962403093, 6648.401643852077, 6650.0, 6666.0, 6670.066190733204, 6260.968695156495, 6321.557490975588, 6330.936690633035, 6463.773767918288, 6465.579737317059], "value": 6172.775916106892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.0, 796.4663675337523, 817.403295594216, 1202.3747651221365, 1246.8503779546456, 36170.27659446813, 36221.73223937166, 36235.094122646944, 36280.0, 36499.635003649986, 36292.63707362926, 36681.0, 36737.0, 36776.44835327465, 36797.0, 7609.809754756134, 7750.651220695054, 8083.151269116746, 8289.502629842229, 8310.376721745863, 8176.1415051419635, 8200.466969646985, 8275.958620206891, 8279.0, 8291.83416331673, 6941.479389045817, 8188.0, 8217.753467395987, 8269.29710974568, 8310.210529999671, 8234.0, 8248.876266856001, 8274.503529788202, 8280.047794503618, 8296.958515207385, 8120.106788253287, 8194.50832950025, 8201.384896132813, 8209.220124088202, 8210.425270231086, 28095.876164953377, 32533.0, 34835.12912177216, 34906.825465872505, 35041.474377884355, 3227.9031629051165, 3525.8413371398346, 3526.7354948378716, 3530.3645343838098, 3534.628863969272, 28999.0, 29027.0, 29043.838246470117, 29090.0, 29098.563521547192, 3049.4663433898977, 3074.446599612069, 3076.9538456923165, 3095.8142511449387, 3107.90676279712, 189677.0, 247576.76211618827, 278847.0, 297340.5132974343, 301913.0, 44998.55001450009, 45285.09429811385, 45456.0, 45479.545204548194, 45504.0, 42330.0, 43980.0, 46861.0, 47851.0, 48026.27960580594, 13838.377273022737, 13860.584182474542, 13950.09324393911, 13969.930150349182, 13972.650683732785, 11528.654140375802, 11540.711482213012, 11550.306981581132, 11561.0, 11568.0, 12997.675058123434, 13139.737205255842, 13140.145890517086, 13165.275909825052, 13226.867731322563, 5842.912356314659, 5887.5289976802605, 5902.321233058167, 5906.645601263938, 5923.0, 966.3380584299778, 976.4629453800524, 996.2826764729383, 1004.8944860789512, 1033.6485594897772, 23294.3011709649, 23454.882725586263, 23573.0, 23623.40941476477, 23653.290401287988, 1087.586717047517, 1094.4965315954591, 1125.1561329003248, 1133.6485689436302, 1136.7101389145714, 11591.76816463666, 12018.875092476019, 12052.819207711891, 12079.818802717966, 12172.330521821385, 297860.5320920188, 303565.44651830243, 322838.0, 324282.0, 326407.0, 50204.49795502071, 50430.9827606899, 50454.49545504498, 50468.0, 50517.747411263445, 1476.1143314011508, 1505.6010157308103, 1549.055076403393, 1549.7830303757482, 1565.8121025477017, 19548.120334585263, 21518.784812151676, 23490.647640285068, 23557.52884942326, 23688.644670329613, 27754.306142346602, 36465.27069458543, 36616.45075323819, 36633.81683091674, 36901.44647830231, 227330.72669273097, 267698.0, 272159.0, 278140.0, 278144.0, 31796.728130874504, 32414.189645259055, 32543.0, 33185.0, 33464.1633959153, 30783.846080769454, 41312.38031429591, 42171.57828421799, 43697.344539832564, 43971.56028439675, 26287.474250515264, 28840.990565330114, 29451.674674640122, 30074.090368251986, 30346.544801828433, 29194.56208156837, 29315.413691726473, 30174.69825301807, 30189.849050754605, 30378.240543985692, 35767.28465430729, 36045.7383991559, 36109.27781444409, 36211.637883620824, 36229.45655815112, 28346.858265709365, 28468.430631386844, 29675.109746707632, 29876.850615746782, 30225.395492090476, 18629.90685046566, 20284.290049848183, 20862.68705969442, 23852.880735596213, 23881.880590596935], "value": 16804.998091459194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.7105990740438, 430.27069117845264, 435.46002956334144, 454.14167223946737, 455.05802987815235, 19250.422487325366, 20583.382498525032, 21106.366808995717, 21303.467413314636, 21394.25120120796, 21515.569688606218, 22630.0, 23422.945967431464, 23453.882730586367, 23674.28977130689, 5421.647592906468, 6190.783322583699, 6375.649339286338, 6396.872062558746, 6408.0, 5858.443447872445, 6107.480864126533, 6110.175126357952, 6136.171616831715, 6182.69086545671, 5957.582969192158, 5997.940020599804, 6115.235595550556, 6120.173776540177, 6126.326104128542, 6057.909131363033, 6139.662318572477, 6146.108814221912, 6148.38516148386, 6150.477209437203, 5260.631755777097, 5372.489613486751, 5454.836354909359, 5456.563474921997, 5502.9174562381595, 27249.591256131174, 27649.0, 27655.446891062267, 27672.446551068864, 27767.166984990483, 2206.172685243034, 2267.2971378872603, 2268.206127855254, 2269.965950510744, 2274.363178310059, 17500.38748643804, 17693.469195924143, 18136.0, 18148.909255453636, 18464.907675461673, 1787.9093752810775, 2094.979050209494, 2153.493928926701, 2158.32012915931, 2160.459885028743, 140204.0, 159218.0, 160640.19679901525, 161009.0, 161203.0, 10294.639687610897, 12160.209586376857, 12740.936295318465, 12749.107562470537, 12798.040146989013, 15677.29452174655, 16465.91767041157, 16466.09436480981, 16473.093979830985, 16483.0, 7691.0, 8880.333974951904, 8989.730308090768, 9072.935515202995, 9161.908380916238, 8660.913390866011, 8669.523176225368, 8699.13008699125, 8833.33749968755, 8853.557322133867, 6484.675766211671, 7969.760907172794, 8088.272055515032, 8147.348212143014, 8155.755327340189, 2165.101482884617, 2175.59751445983, 2182.6616874384495, 2193.6928829963817, 2344.9531009379716, 938.5354249646332, 952.5427794658602, 958.8561715742694, 968.2641192693462, 993.9751506212402, 16395.0, 21053.578928421346, 21556.137754489646, 21659.891700541397, 21791.45521361947, 888.2849306308484, 932.4079209701888, 941.2517048946104, 982.6658935961807, 1007.9143272821746, 10115.747106322253, 10938.398388088572, 11227.045701115496, 11238.044766194966, 11247.718807029889, 503758.0, 527476.0, 530336.0, 551675.0, 556256.0, 131460.0, 132494.0, 140210.0, 140556.48568923076, 149648.25175874052, 1102.167863263231, 1161.6863446869297, 1208.1482554799022, 1252.9624111276676, 1260.7667581497453, 17089.91455042717, 18467.353642622445, 18639.627207456047, 22873.0, 23103.884480578163, 60601.696991516525, 60632.393676062675, 61407.38592614017, 62443.06335405063, 62626.0, 84363.5781821087, 85181.57409212914, 85838.0, 85860.57069714612, 85879.0, 9112.95443522778, 9114.088591140833, 9172.669962855482, 9228.676996305365, 9368.531573421165, 14416.062955907832, 14498.85501144975, 14632.70734585281, 14738.926305368404, 15082.54752357431, 9682.612695492102, 11685.474153662935, 12000.459979300778, 12273.570425035081, 12467.93766031164, 11725.061995040547, 11766.470508827295, 11862.644120676394, 12096.395180241128, 12165.33090680021, 11558.42207889619, 11568.07455403549, 11570.826437603611, 12777.59173085284, 12887.48450061987, 8929.508877011827, 8973.0, 9057.049009854134, 9181.449113052971, 9268.212201962908, 12126.0, 12183.329916854304, 12342.506299747909, 12401.813972790596, 12433.316167610868], "value": 10561.52195852515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.588006538071, 1429.4282287085164, 1451.4194322271085, 1461.3789139615667, 1466.2155746675523, 11244.269122507032, 11676.241044332122, 11728.648140555797, 11769.470373833177, 11847.407629618529, 11605.071594272458, 11623.01204397625, 11784.292942423439, 11792.410379481013, 11826.94086529566, 2130.28635407138, 2235.2400183937457, 2496.213692686807, 2553.48930213957, 2553.6297236900637, 1972.6942323939813, 2465.9753402466013, 2526.103233352161, 2526.987365063172, 2533.4679717259396, 2418.419579300964, 2429.283361408389, 2472.4807790363957, 2475.7029156501153, 2479.3181874984434, 2421.4793819328843, 2449.4243852694603, 2484.8012159027326, 2486.2292689266205, 2491.451880586268, 2076.439361372436, 2422.2369953464604, 2459.2499287717237, 2482.1064416809936, 2528.3679080229945, 11536.769264614744, 11606.94196529012, 11698.883011169864, 11709.0, 11715.882841171564, 6424.486041116699, 6605.801825945229, 6671.733130674767, 6686.431653309426, 6688.030235615857, 4014.4781178446906, 4292.806823692941, 4382.211201983641, 4395.450568678915, 4403.581659742352, 1262.0912942681255, 1266.5877546535546, 1304.3347892574855, 1313.0349193342886, 1317.9670508237275, 15208.847911520854, 15658.68682626341, 15780.526584202493, 15785.842141578438, 15797.763033554505, 5550.750216240198, 5620.4098569649595, 5700.97149514258, 5792.478676919013, 5808.39011903744, 11932.105092118127, 11932.880671193177, 11982.58060967862, 12008.699782505333, 12021.819672704916, 6558.80323590293, 6591.176102987127, 6605.141331626858, 6606.042123892009, 6626.9337306627285, 5971.880562388728, 6194.132821405007, 6210.068489726577, 6230.968845155836, 6234.376562343729, 4032.052467670095, 4248.851290204828, 4362.672799539983, 4372.912541749147, 4415.580519850609, 1140.1733743036232, 1279.05350040969, 1282.6665067082627, 1286.01619760883, 1287.7875150600235, 685.2291172431015, 796.7729197178776, 805.8549461097059, 816.9591520423955, 822.4201937633953, 6467.870642587122, 6937.271586483447, 6951.6871740771785, 7150.356467917808, 7278.454115941326, 798.4730078148394, 926.1849572376266, 930.3766476460787, 938.5588773276686, 955.7992821507422, 4252.29837076885, 4294.7852607369505, 4357.694961352675, 4431.778411079433, 4454.374153434038, 13652.249126297951, 13988.650283742987, 14035.298235088205, 14067.155970641794, 14091.85908140926, 13851.376688049062, 13913.443462261395, 13933.58199254024, 14076.014678972579, 14470.421183152555, 7446.962765186247, 8377.832443351099, 8590.441621294722, 8595.613197406132, 8600.010998735226, 5731.828045158652, 6251.218597675291, 6522.510811689048, 6889.586624802528, 6961.0, 12725.80911286313, 12926.224426534438, 13128.015398844935, 13322.733545329233, 13427.19436833793, 13113.868861311264, 13269.800952985519, 13279.734405312032, 13565.796513052115, 13571.0, 9212.631494740403, 9228.446293222429, 9283.303752218475, 9338.859917101114, 9402.95298523503, 8808.427452215585, 10561.419121948367, 10635.8936410638, 10647.72227332725, 10662.200334974752, 8793.736187914374, 9067.04795996411, 9121.589528471368, 9141.0, 9193.724188274362, 8799.736007919773, 8826.823463530565, 8858.689945851864, 8927.241184499131, 9048.864267036131, 6712.328767123248, 6935.549189302679, 7996.280334769898, 8048.5975701215875, 8065.314448271963, 5134.743262836918, 5298.708571028476, 5914.0, 5959.195508606283, 6077.20996270482, 6039.758409663565, 6066.605670631395, 6227.159333489921, 6262.123302737529, 6360.014197799349], "value": 5319.101321101572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.9814715989286, 405.21792939626516, 406.59949949299937, 407.76553481747993, 415.22767652166965, 5233.712145831978, 5275.419703832576, 5434.375046869611, 6316.968415157923, 6335.909149980507, 4666.743329116897, 5273.446288139738, 6072.908906366408, 6130.386961303868, 6296.401841825019, 4158.334666453368, 4388.736675799446, 4405.185040767468, 4717.056588682261, 4751.762411879392, 4245.554216807222, 4445.22208613493, 4447.822087116511, 4452.265376212921, 4452.441645424108, 3827.8086095695244, 4414.845480408187, 4432.667549933752, 4440.86677399677, 4446.844360447385, 4389.802458889326, 4393.923488745246, 4427.070315233788, 4438.42300500936, 4461.709988850746, 3441.7590768646205, 3768.2651882882847, 3773.3962565989586, 3793.943090853639, 3800.6769424598942, 5983.1623572699855, 6003.8198854034445, 6003.969980150071, 6008.188894499231, 6021.548383871227, 5167.250748641463, 5219.739013049332, 5253.343332083489, 5270.604704647167, 5308.5487733542695, 6529.233659428596, 6549.476041916635, 6553.508486863504, 6553.770618028394, 6587.50593705474, 3384.627690953993, 4304.268274393361, 4306.074194048263, 4309.224339618867, 4352.194843953847, 6438.871222575569, 6870.0, 6955.304469553055, 7013.789586312419, 7122.290650243956, 4340.0, 4355.499117601516, 4368.410264614236, 4377.78111094444, 4379.386885835986, 3717.498137751423, 4054.432379466877, 4141.047559061432, 4428.33574963758, 4464.776761161929, 4839.201531747292, 4876.756162191876, 5059.0, 5295.279034313787, 5309.0, 6569.146011018537, 6678.4991125665765, 6679.0, 6683.598984060972, 6717.6977036033495, 1504.8645621894082, 1519.2555647732531, 1522.9771553426708, 1524.7941527893593, 1525.22311507093, 806.26629766913, 964.5514835601479, 979.0894468144552, 985.605757696927, 1002.6791426743372, 5612.635178713453, 6053.818385448443, 6339.96830015847, 6350.587211831308, 6362.681865906686, 5200.843974680765, 6249.5626705584855, 6568.047633093175, 6941.722331106699, 6943.305669433016, 4765.309030190603, 5510.91733623988, 6187.752489900444, 6272.498200143978, 6381.489480841522, 2948.8673009714616, 3612.6387361263664, 3614.6566076222716, 3622.492851000862, 3624.8187590620364, 6316.9368306317265, 6875.69966416123, 6904.378605925491, 6942.618156001468, 7166.175889772639, 5865.296164460292, 6634.0, 7132.17979932304, 7145.6784444700115, 7182.640867956581, 6771.492138089663, 7120.520326502961, 7157.6779044943105, 7196.964015179995, 7209.927900720925, 5314.8937021260135, 5870.53035757147, 5953.672548009901, 6069.696515174312, 6904.4131248844415, 6203.906941395973, 6738.629375384205, 6800.777288780908, 6862.176538815374, 6884.208316043719, 6803.0, 6997.755078572225, 7244.927550724426, 7248.311410416002, 7281.927180728337, 4966.478519755374, 4968.857162852636, 4995.400551933646, 4998.225275082368, 5040.57155141817, 5891.410858914074, 6048.667323297085, 6705.463562914858, 6896.413804826646, 6967.686454109678, 5858.179854820414, 6670.966645166744, 6676.866462670817, 6760.0, 6766.898496522655, 6301.495880329654, 6529.444997175104, 6643.534952553468, 6728.966355168192, 6734.3602357775935, 6452.677366131581, 6480.805575832733, 6497.610143391223, 6497.642629655415, 6510.112067500372, 6455.966370593248, 6612.801615951529, 6658.966705166443, 6662.766803161866, 6700.061991321121, 5206.167013277857, 5330.733463326896, 5611.438856114356, 6467.708953097216, 6531.738730450728], "value": 4763.919223661714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.1552792859392, 817.52992029583, 826.107803572142, 855.0210009539078, 861.9870701939471, 15884.682306353867, 16448.91775541122, 16864.494065178034, 16901.070441125732, 18278.817211827878, 17752.556186095353, 18027.0, 18092.0, 18145.54636134094, 18322.35871744489, 983.1888691829251, 991.0436428846162, 998.3710262534593, 1000.194843151263, 1004.6483730694272, 1004.8643433136542, 1016.8678071850649, 1020.6427750287414, 1022.5858527296419, 1023.9283250172491, 1046.6650671785033, 1052.273930987616, 1056.4453661827563, 1056.9958539387574, 1057.2863317260856, 1035.3994683083793, 1042.249580302185, 1057.984130238047, 1058.539535302146, 1058.8623478947688, 753.5365750063671, 770.1874522378888, 773.3581127664025, 783.2989474420361, 788.5820515126992, 16411.015339079695, 16637.918535295168, 16767.83232167687, 16775.32898684051, 16776.245068971926, 17150.82849171505, 17185.570360740956, 17535.386261480915, 17631.5592110197, 17792.288308467647, 13987.860121398859, 14050.43798248069, 14147.787783183261, 14252.572422827332, 14285.285735713172, 3426.5716785401823, 3486.9651303486894, 3487.7907325560545, 3490.0925759302763, 3494.637091534278, 115700.42149789198, 131985.34007329997, 133773.33113334468, 135158.0, 137729.0, 13146.737065258641, 13347.399367028313, 13367.398467069006, 13523.797143042862, 13544.796828047587, 23921.0, 24158.79206039726, 25741.485170296488, 25908.740912590634, 26401.735982639926, 7492.026036615205, 7526.811829704301, 7531.548107113591, 7562.584057876759, 7613.9238607613215, 3736.551613806361, 3783.1866148778145, 3814.504114465102, 3818.3317919364, 3819.2934307153264, 3936.173403585222, 4114.629683328515, 4372.0818628088455, 4380.518143004267, 4392.3411488277015, 779.9376049915993, 896.1844721303713, 902.634433054614, 910.1399177776938, 911.4030310146865, 646.7251418147268, 653.6176336842905, 655.8393193667582, 666.8366250268715, 683.987698206647, 10968.670939871816, 11654.951054405145, 11790.351530665896, 11826.231294965972, 13459.865401346056, 648.7178077536192, 656.9408753212139, 658.3449467779494, 681.0703389872887, 683.6786710246176, 5201.557867581222, 5218.347706536683, 5281.207818827206, 5436.972815135899, 5556.861078473071, 108573.45713271383, 110903.0, 110923.44538277257, 110962.0, 113610.43194783974, 95850.0, 96857.06285874384, 97738.51130744301, 98663.52004719934, 99148.5042574797, 85112.57443712742, 85316.333583623, 86324.56837715897, 86564.0, 87294.0, 9870.851937220803, 10761.085307748615, 10999.120070394189, 11127.1654625905, 11226.382548959886, 41846.37230441485, 42149.0, 43202.567974319856, 43284.78357608192, 43505.56494435015, 55088.72455637696, 55394.72302638461, 55856.0, 56267.718661406434, 56599.30202093944, 14010.859891400956, 14061.367238474499, 14094.859051409765, 14419.42322307096, 14480.927595361956, 15516.689666206386, 15588.844111559192, 15706.685866282382, 15740.68518629644, 15772.132532710812, 14071.437142514185, 14110.130273385052, 14433.78349324782, 14775.408983640535, 14795.482158124414, 11939.0, 14290.57128286153, 14517.564473065824, 14562.563123106323, 14572.927135364256, 11273.605423810455, 13874.098183618033, 14003.649908752363, 14485.420583176556, 14493.057951233137, 10478.947605261925, 10531.315464494783, 10661.307015044307, 10775.6228532001, 10782.568697252022, 10886.61896833607, 10933.945330273298, 11273.549058037586, 11687.590934317259, 11888.643340699447], "value": 8189.136927607236, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 124.0, 171.0, 123.0, 117.0, 115.0, 114.0, 117.0, 116.0, 116.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 114.0, 151.0, 111.0, 116.0, 156.0, 95.0, 138.0, 161.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 204.0, 201.0, 229.0, 210.0, 221.0, 197.0, 197.0, 236.0, 278.0], "value": 217.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 88.0, 116.0, 65.0, 59.0, 58.0, 59.0, 78.0, 69.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 67.0, 82.0, 72.0, 69.0, 76.0, 79.0, 71.0, 110.0, 114.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 90.0, 94.0, 91.0, 91.0, 91.0, 94.0, 134.0, 140.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 99.0, 99.0, 96.0, 100.0, 98.0, 98.0, 137.0, 102.0, 149.0], "value": 107.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 93.0, 82.0, 141.0, 142.0, 97.0, 141.0, 92.0, 142.0], "value": 110.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 48.0, 49.0, 49.0, 51.0, 51.0, 47.0, 50.0, 50.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 62.0, 60.0, 65.0, 61.0, 56.0, 59.0, 60.0, 58.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 85.0, 84.0, 82.0, 83.0, 83.0, 82.0, 80.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 173.0, 152.0, 154.0, 152.0, 153.0, 155.0, 224.0, 159.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 188.0, 182.0, 189.0, 189.0, 176.0, 182.0, 187.0, 221.0, 237.0], "value": 197.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 69.0, 64.0, 65.0, 64.0, 66.0, 69.0, 68.0, 72.0], "value": 67.3, "unit": "score"}]}]} 17:57:37 INFO - Return code: 0 17:57:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:57:37 ERROR - # TBPL SUCCESS # 17:57:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:57:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:57:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:57:37 INFO - 2017-05-01 17:57:37.547 screenresolution[1662:10662] starting screenresolution argv=screenresolution get 17:57:37 INFO - 2017-05-01 17:57:37.550 screenresolution[1662:10662] Display 0: 1600x1200x32@60 17:57:37 INFO - 2017-05-01 17:57:37.557 screenresolution[1663:10665] starting screenresolution argv=screenresolution list 17:57:37 INFO - Available Modes on Display 0 17:57:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:57:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:57:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:57:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:57:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:57:37 INFO - Intel Iris: 17:57:37 INFO - Chipset Model: Intel Iris 17:57:37 INFO - Type: GPU 17:57:37 INFO - Bus: Built-In 17:57:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:57:37 INFO - Vendor: Intel (0x8086) 17:57:37 INFO - Device ID: 0x0a2e 17:57:37 INFO - Revision ID: 0x0009 17:57:37 INFO - Displays: 17:57:37 INFO - Display: 17:57:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:57:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:57:37 INFO - Display Serial Number: 1600x1200 60 17:57:37 INFO - Main Display: Yes 17:57:37 INFO - Mirror: Off 17:57:37 INFO - Online: Yes 17:57:37 INFO - Rotation: Supported 17:57:37 INFO - Return code: 0 17:57:37 INFO - Running post-action listener: _resource_record_post_action 17:57:37 INFO - [mozharness: 2017-05-02 00:57:37.801551Z] Finished run-tests step (success) 17:57:37 INFO - Running post-run listener: _resource_record_post_run 17:57:37 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 39365632; Write bytes: 513370112; Read time: 258; Write time: 1626 17:57:37 INFO - TinderboxPrint: CPU usage
54.1% 17:57:37 INFO - TinderboxPrint: I/O read bytes / time
39,365,632 / 258 17:57:37 INFO - TinderboxPrint: I/O write bytes / time
513,370,112 / 1,626 17:57:37 INFO - TinderboxPrint: CPU idle
2,201.4 (45.9%) 17:57:37 INFO - TinderboxPrint: CPU system
967.0 (20.2%) 17:57:37 INFO - TinderboxPrint: CPU user
1,625.3 (33.9%) 17:57:37 INFO - TinderboxPrint: Swap in / out
247,996,416 / 0 17:57:37 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205949440; Write bytes: 205858816; Read time: 15932; Write time: 437 17:57:37 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37260288; Write bytes: 300494848; Read time: 238; Write time: 1161 17:57:38 INFO - Running post-run listener: _upload_blobber_files 17:57:38 INFO - Blob upload gear active. 17:57:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:57:38 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 17:57:38 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'] 17:57:38 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 17:57:38 INFO - (blobuploader) - INFO - Open directory for files ... 17:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:39 INFO - (blobuploader) - INFO - Done attempting. 17:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:41 INFO - (blobuploader) - INFO - Done attempting. 17:57:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:57:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:42 INFO - (blobuploader) - INFO - Done attempting. 17:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:57:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:44 INFO - (blobuploader) - INFO - Done attempting. 17:57:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:44 INFO - Return code: 0 17:57:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91cb23e0cc2f565e79b161e445b85c63e31034831630ac77bf965d0abf4adae27f5c8837879f9c173681828d7f7d7375c98ed131b41c980108e02fc29dab6b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15e10998cc848384a31d6db991e54de44ca4a2c8e5a1cc661151a4a0ec73aba64f7e67d5e222ed0b4fdf0f694f21fbbc5e0e9020c0d738f2ca634701d0483679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/448dc7fd3fadf7e4c63df4ecfa314a04801f575450f6103e7dd176174d14ddf72944dae1a97e21818e23de586aa2aa581d72a1b9ff0cee17522a6fd43c5152c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b47637f4e0ee69b2e62ec2ab7cbc97f65464c48eb1b266bd8afa1fe42dd75979dc9ac25c8080845a083fd3d218f3f895b248ac3325d41fccae7d3e2c1678faaf"} 17:57:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:44 INFO - Contents: 17:57:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91cb23e0cc2f565e79b161e445b85c63e31034831630ac77bf965d0abf4adae27f5c8837879f9c173681828d7f7d7375c98ed131b41c980108e02fc29dab6b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15e10998cc848384a31d6db991e54de44ca4a2c8e5a1cc661151a4a0ec73aba64f7e67d5e222ed0b4fdf0f694f21fbbc5e0e9020c0d738f2ca634701d0483679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/448dc7fd3fadf7e4c63df4ecfa314a04801f575450f6103e7dd176174d14ddf72944dae1a97e21818e23de586aa2aa581d72a1b9ff0cee17522a6fd43c5152c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b47637f4e0ee69b2e62ec2ab7cbc97f65464c48eb1b266bd8afa1fe42dd75979dc9ac25c8080845a083fd3d218f3f895b248ac3325d41fccae7d3e2c1678faaf"} 17:57:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:44 INFO - Copying logs to upload dir... 17:57:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.522955 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-05-01 17:57:44.675678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 17:57:44.678814) ========= 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.aekHdqMSiv/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.dO7JeUXVP0/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/91cb23e0cc2f565e79b161e445b85c63e31034831630ac77bf965d0abf4adae27f5c8837879f9c173681828d7f7d7375c98ed131b41c980108e02fc29dab6b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15e10998cc848384a31d6db991e54de44ca4a2c8e5a1cc661151a4a0ec73aba64f7e67d5e222ed0b4fdf0f694f21fbbc5e0e9020c0d738f2ca634701d0483679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/448dc7fd3fadf7e4c63df4ecfa314a04801f575450f6103e7dd176174d14ddf72944dae1a97e21818e23de586aa2aa581d72a1b9ff0cee17522a6fd43c5152c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b47637f4e0ee69b2e62ec2ab7cbc97f65464c48eb1b266bd8afa1fe42dd75979dc9ac25c8080845a083fd3d218f3f895b248ac3325d41fccae7d3e2c1678faaf"} build_url:https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010050 build_url: 'https://queue.taskcluster.net/v1/task/Z4mUduebSnmxEe2egK5FSg/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/91cb23e0cc2f565e79b161e445b85c63e31034831630ac77bf965d0abf4adae27f5c8837879f9c173681828d7f7d7375c98ed131b41c980108e02fc29dab6b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15e10998cc848384a31d6db991e54de44ca4a2c8e5a1cc661151a4a0ec73aba64f7e67d5e222ed0b4fdf0f694f21fbbc5e0e9020c0d738f2ca634701d0483679", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/448dc7fd3fadf7e4c63df4ecfa314a04801f575450f6103e7dd176174d14ddf72944dae1a97e21818e23de586aa2aa581d72a1b9ff0cee17522a6fd43c5152c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b47637f4e0ee69b2e62ec2ab7cbc97f65464c48eb1b266bd8afa1fe42dd75979dc9ac25c8080845a083fd3d218f3f895b248ac3325d41fccae7d3e2c1678faaf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 17:57:44.714457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:57:44.714830) ========= 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.aekHdqMSiv/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.dO7JeUXVP0/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.004880 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 17:57:44.764484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 17:57:44.764860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 17:57:44.765221) ========= ========= Total master_lag: 0.18 =========