builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1504346204.95 results: success (0) revision: a46a5879b8781ae9ea99f37b5d34a891f0f75047 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:44.949664) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:44.950161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:44.950445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:44.968097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:44.968435) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-02 02:56:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 99.7M=0s 2017-09-02 02:56:45 (99.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:45.104976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:45.105294) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015040 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:45.154821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-02 02:56:45.155209) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a46a5879b8781ae9ea99f37b5d34a891f0f75047 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a46a5879b8781ae9ea99f37b5d34a891f0f75047 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-02 02:56:45,209 truncating revision to first 12 chars 2017-09-02 02:56:45,209 Setting DEBUG logging. 2017-09-02 02:56:45,209 attempt 1/10 2017-09-02 02:56:45,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a46a5879b878?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-02 02:56:46,570 unpacking tar archive at: mozilla-central-a46a5879b878/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-02 02:56:46.854859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:46.855174) ========= script_repo_revision: a46a5879b8781ae9ea99f37b5d34a891f0f75047 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:46.855562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:46.856097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 02:56:46.869580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-09-02 02:56:46.869940) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:56:47 INFO - MultiFileLogger online at 20170902 02:56:47 in /builds/slave/test 02:56:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:56:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:47 INFO - {'append_to_log': False, 02:56:47 INFO - 'base_work_dir': '/builds/slave/test', 02:56:47 INFO - 'blob_upload_branch': 'Firefox', 02:56:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:47 INFO - 'branch': 'Firefox', 02:56:47 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:47 INFO - 'code_coverage': False, 02:56:47 INFO - 'config_files': ('talos/linux_config.py',), 02:56:47 INFO - 'default_actions': ('clobber', 02:56:47 INFO - 'read-buildbot-config', 02:56:47 INFO - 'download-and-extract', 02:56:47 INFO - 'populate-webroot', 02:56:47 INFO - 'create-virtualenv', 02:56:47 INFO - 'install', 02:56:47 INFO - 'setup-mitmproxy', 02:56:47 INFO - 'run-tests'), 02:56:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:47 INFO - 'disable_ccov_upload': False, 02:56:47 INFO - 'disable_stylo': False, 02:56:47 INFO - 'download_minidump_stackwalk': True, 02:56:47 INFO - 'download_symbols': 'ondemand', 02:56:47 INFO - 'enable_stylo': False, 02:56:47 INFO - 'enable_webrender': False, 02:56:47 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:56:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:47 INFO - 'gecko_profile': False, 02:56:47 INFO - 'gecko_profile_interval': 0, 02:56:47 INFO - 'installer_path': 'installer.exe', 02:56:47 INFO - 'log_level': 'info', 02:56:47 INFO - 'log_name': 'talos', 02:56:47 INFO - 'log_to_console': True, 02:56:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:56:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:56:47 INFO - 'opt_config_files': (), 02:56:47 INFO - 'pip_index': False, 02:56:47 INFO - 'suite': 'dromaeojs-e10s', 02:56:47 INFO - 'system_bits': '32', 02:56:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:47 INFO - 'title': 'talos-linux64-ix-056', 02:56:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:47 INFO - 'use_talos_json': True, 02:56:47 INFO - 'verify': 'False', 02:56:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:47 INFO - 'work_dir': 'build'} 02:56:47 INFO - [mozharness: 2017-09-02 09:56:47.061632Z] Running clobber step. 02:56:47 INFO - Running pre-action listener: _resource_record_pre_action 02:56:47 INFO - Running main action method: clobber 02:56:47 INFO - rmtree: /builds/slave/test/build 02:56:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:56:48 INFO - Running post-action listener: _resource_record_post_action 02:56:48 INFO - [mozharness: 2017-09-02 09:56:48.089354Z] Finished clobber step (success) 02:56:48 INFO - [mozharness: 2017-09-02 09:56:48.089451Z] Running read-buildbot-config step. 02:56:48 INFO - Running pre-action listener: _resource_record_pre_action 02:56:48 INFO - Running main action method: read_buildbot_config 02:56:48 INFO - Using buildbot properties: 02:56:48 INFO - { 02:56:48 INFO - "project": "", 02:56:48 INFO - "product": "firefox", 02:56:48 INFO - "who": "archaeopteryx@coole-files.de", 02:56:48 INFO - "installer_path": "public/build/target.tar.bz2", 02:56:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:56:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:56:48 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:56:48 INFO - "stage_platform": "linux64-qr", 02:56:48 INFO - "basedir": "/builds/slave/test", 02:56:48 INFO - "buildnumber": 27, 02:56:48 INFO - "platform": "ubuntu64_hw_qr", 02:56:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:56:48 INFO - "slavebuilddir": "test", 02:56:48 INFO - "taskId": "eEin6-MNSR-BjTQcXoP7Ww", 02:56:48 INFO - "branch": "mozilla-central", 02:56:48 INFO - "script_repo_revision": "production", 02:56:48 INFO - "revision": "a46a5879b8781ae9ea99f37b5d34a891f0f75047", 02:56:48 INFO - "slavename": "talos-linux64-ix-056", 02:56:48 INFO - "repo_path": "mozilla-central" 02:56:48 INFO - } 02:56:48 INFO - Finding installer, test and symbols from parent task. 02:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEin6-MNSR-BjTQcXoP7Ww'}, attempt #1 02:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eEin6-MNSR-BjTQcXoP7Ww'}, attempt #1 02:56:48 INFO - Task dependencies: elhbt6dOSlyDfLTG7lCKow 02:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow'}, attempt #1 02:56:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2 02:56:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.test_packages.json 02:56:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.crashreporter-symbols.zip 02:56:49 INFO - Running post-action listener: _resource_record_post_action 02:56:49 INFO - [mozharness: 2017-09-02 09:56:49.421166Z] Finished read-buildbot-config step (success) 02:56:49 INFO - [mozharness: 2017-09-02 09:56:49.421385Z] Running download-and-extract step. 02:56:49 INFO - Running pre-action listener: _resource_record_pre_action 02:56:49 INFO - Running main action method: download_and_extract 02:56:49 INFO - mkdir: /builds/slave/test/build/tests 02:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:49 INFO - trying https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.test_packages.json 02:56:49 INFO - Downloading https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:56:49 INFO - Downloaded 989 bytes. 02:56:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:56:49 INFO - Using the following test package requirements: 02:56:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:56:49 INFO - u'common': [u'target.common.tests.zip'], 02:56:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:56:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:56:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:56:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:56:49 INFO - u'mozbase': [u'target.common.tests.zip'], 02:56:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:56:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:56:49 INFO - u'web-platform': [u'target.common.tests.zip', 02:56:49 INFO - u'target.web-platform.tests.tar.gz'], 02:56:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:56:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:56:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.common.tests.zip 02:56:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:56:49 INFO - Fetch https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.common.tests.zip into memory 02:56:51 INFO - Content-Length response header: 55022295 02:56:51 INFO - Bytes received: 55022295 02:57:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:57:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.common.tests.zip 02:57:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:57:02 INFO - Fetch https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.common.tests.zip into memory 02:57:03 INFO - Content-Length response header: 55022295 02:57:03 INFO - Bytes received: 55022295 02:57:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.talos.tests.zip 02:57:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:57:18 INFO - Fetch https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.talos.tests.zip into memory 02:57:19 INFO - Content-Length response header: 14496650 02:57:19 INFO - Bytes received: 14496650 02:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:19 INFO - trying https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2 02:57:19 INFO - Downloading https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:57:20 INFO - Downloaded 62640288 bytes. 02:57:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2 02:57:20 INFO - mkdir: /builds/slave/test/properties 02:57:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:20 INFO - Contents: 02:57:20 INFO - build_url:https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2 02:57:20 INFO - Running post-action listener: _resource_record_post_action 02:57:20 INFO - Running post-action listener: find_tests_for_verification 02:57:20 INFO - Running post-action listener: set_extra_try_arguments 02:57:20 INFO - [mozharness: 2017-09-02 09:57:20.643020Z] Finished download-and-extract step (success) 02:57:20 INFO - [mozharness: 2017-09-02 09:57:20.643117Z] Running populate-webroot step. 02:57:20 INFO - Running pre-action listener: _resource_record_pre_action 02:57:20 INFO - Running main action method: populate_webroot 02:57:20 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:20 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:20 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:20 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'tests': ['damp', 'tps']}, 02:57:20 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['damp', 'tps']}, 02:57:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:57:20 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:57:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:57:20 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:57:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:20 INFO - 'ts_paint', 02:57:20 INFO - 'tpaint', 02:57:20 INFO - 'sessionrestore', 02:57:20 INFO - 'sessionrestore_many_windows', 02:57:20 INFO - 'sessionrestore_no_auto_restore', 02:57:20 INFO - 'tabpaint']}, 02:57:20 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['a11yr', 02:57:20 INFO - 'ts_paint', 02:57:20 INFO - 'tpaint', 02:57:20 INFO - 'sessionrestore', 02:57:20 INFO - 'sessionrestore_many_windows', 02:57:20 INFO - 'sessionrestore_no_auto_restore', 02:57:20 INFO - 'tabpaint']}, 02:57:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:57:20 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:57:20 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['bloom_basic_singleton']}, 02:57:20 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['bloom_basic']}, 02:57:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:20 INFO - 'tsvgr_opacity', 02:57:20 INFO - 'tart', 02:57:20 INFO - 'tscrollx', 02:57:20 INFO - 'tsvg_static']}, 02:57:20 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['tsvgx', 02:57:20 INFO - 'tsvgr_opacity', 02:57:20 INFO - 'tart', 02:57:20 INFO - 'tscrollx', 02:57:20 INFO - 'tsvg_static']}, 02:57:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:20 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo'], 02:57:20 INFO - 'tests': ['tp5o']}, 02:57:20 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:20 INFO - 'talos_options': ['--mitmproxy', 02:57:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:20 INFO - '--firstNonBlankPaint'], 02:57:20 INFO - 'tests': ['tp6_google', 02:57:20 INFO - 'tp6_youtube', 02:57:20 INFO - 'tp6_amazon', 02:57:20 INFO - 'tp6_facebook']}, 02:57:20 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo', 02:57:20 INFO - '--mitmproxy', 02:57:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:20 INFO - '--firstNonBlankPaint'], 02:57:20 INFO - 'tests': ['tp6_google', 02:57:20 INFO - 'tp6_youtube', 02:57:20 INFO - 'tp6_amazon', 02:57:20 INFO - 'tp6_facebook']}, 02:57:20 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo', 02:57:20 INFO - '--stylo-threads=1', 02:57:20 INFO - '--mitmproxy', 02:57:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:20 INFO - '--firstNonBlankPaint'], 02:57:20 INFO - 'tests': ['tp6_google', 02:57:20 INFO - 'tp6_youtube', 02:57:20 INFO - 'tp6_amazon', 02:57:20 INFO - 'tp6_facebook']}, 02:57:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'talos_options': ['--xperf_path', 02:57:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:20 INFO - 'tests': ['tp5n']}, 02:57:20 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:57:20 INFO - 'talos_options': ['--enable-stylo', 02:57:20 INFO - '--xperf_path', 02:57:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:20 INFO - 'tests': ['tp5n']}}} 02:57:20 INFO - Running post-action listener: _resource_record_post_action 02:57:20 INFO - [mozharness: 2017-09-02 09:57:20.657411Z] Finished populate-webroot step (success) 02:57:20 INFO - [mozharness: 2017-09-02 09:57:20.657501Z] Running create-virtualenv step. 02:57:20 INFO - Running pre-action listener: _resource_record_pre_action 02:57:20 INFO - Running main action method: create_virtualenv 02:57:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:20 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:57:20 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:57:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:57:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:21 INFO - Installing pip...............done. 02:57:21 INFO - Return code: 0 02:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:21 INFO - Reading from file tmpfile_stdout 02:57:21 INFO - Output received: 02:57:21 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:21 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:57:21 INFO - Using env: {'DISPLAY': ':0', 02:57:21 INFO - 'HOME': '/home/cltbld', 02:57:21 INFO - 'LANG': 'en_US.UTF-8', 02:57:21 INFO - 'LANGUAGE': 'en_US:en', 02:57:21 INFO - 'LOGNAME': 'cltbld', 02:57:21 INFO - 'MAIL': '/var/mail/cltbld', 02:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:21 INFO - 'MOZ_NO_REMOTE': '1', 02:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:21 INFO - 'NO_EM_RESTART': '1', 02:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:21 INFO - 'PWD': '/builds/slave/test', 02:57:21 INFO - 'SHELL': '/bin/bash', 02:57:21 INFO - 'SHLVL': '1', 02:57:21 INFO - 'TERM': 'linux', 02:57:21 INFO - 'TMOUT': '86400', 02:57:21 INFO - 'USER': 'cltbld', 02:57:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:21 INFO - '_': '/tools/buildbot/bin/python'} 02:57:22 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:57:22 INFO - Downloading/unpacking pip>=1.5 02:57:22 INFO - Running setup.py egg_info for package pip 02:57:22 INFO - warning: no files found matching 'pip/cacert.pem' 02:57:22 INFO - warning: no files found matching '*.html' under directory 'docs' 02:57:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:57:22 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:57:22 INFO - Installing collected packages: pip 02:57:22 INFO - Found existing installation: pip 1.1 02:57:22 INFO - Uninstalling pip: 02:57:22 INFO - Successfully uninstalled pip 02:57:22 INFO - Running setup.py install for pip 02:57:22 INFO - warning: no files found matching 'pip/cacert.pem' 02:57:22 INFO - warning: no files found matching '*.html' under directory 'docs' 02:57:22 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:57:22 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:57:22 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:57:22 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:57:22 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:57:22 INFO - Successfully installed pip 02:57:22 INFO - Cleaning up... 02:57:22 INFO - Return code: 0 02:57:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:22 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:57:22 INFO - Using env: {'DISPLAY': ':0', 02:57:22 INFO - 'HOME': '/home/cltbld', 02:57:22 INFO - 'LANG': 'en_US.UTF-8', 02:57:22 INFO - 'LANGUAGE': 'en_US:en', 02:57:22 INFO - 'LOGNAME': 'cltbld', 02:57:22 INFO - 'MAIL': '/var/mail/cltbld', 02:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:22 INFO - 'MOZ_NO_REMOTE': '1', 02:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:22 INFO - 'NO_EM_RESTART': '1', 02:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:22 INFO - 'PWD': '/builds/slave/test', 02:57:22 INFO - 'SHELL': '/bin/bash', 02:57:22 INFO - 'SHLVL': '1', 02:57:22 INFO - 'TERM': 'linux', 02:57:22 INFO - 'TMOUT': '86400', 02:57:22 INFO - 'USER': 'cltbld', 02:57:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:22 INFO - '_': '/tools/buildbot/bin/python'} 02:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:23 INFO - Downloading/unpacking psutil>=3.1.1 02:57: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 02:57: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 02:57: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 02:57: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 02:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:24 INFO - Installing collected packages: psutil 02:57:24 INFO - Running setup.py install for psutil 02:57:24 INFO - building 'psutil._psutil_linux' extension 02:57:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:57:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:57:24 INFO - building 'psutil._psutil_posix' extension 02:57:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:57:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:24 INFO - Successfully installed psutil 02:57:24 INFO - Cleaning up... 02:57:24 INFO - Return code: 0 02:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:24 INFO - Using env: {'DISPLAY': ':0', 02:57:24 INFO - 'HOME': '/home/cltbld', 02:57:24 INFO - 'LANG': 'en_US.UTF-8', 02:57:24 INFO - 'LANGUAGE': 'en_US:en', 02:57:24 INFO - 'LOGNAME': 'cltbld', 02:57:24 INFO - 'MAIL': '/var/mail/cltbld', 02:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:24 INFO - 'MOZ_NO_REMOTE': '1', 02:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:24 INFO - 'NO_EM_RESTART': '1', 02:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:24 INFO - 'PWD': '/builds/slave/test', 02:57:24 INFO - 'SHELL': '/bin/bash', 02:57:24 INFO - 'SHLVL': '1', 02:57:24 INFO - 'TERM': 'linux', 02:57:24 INFO - 'TMOUT': '86400', 02:57:24 INFO - 'USER': 'cltbld', 02:57:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:24 INFO - '_': '/tools/buildbot/bin/python'} 02:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:26 INFO - Installing collected packages: mozsystemmonitor 02:57:26 INFO - Running setup.py install for mozsystemmonitor 02:57:26 INFO - Successfully installed mozsystemmonitor 02:57:26 INFO - Cleaning up... 02:57:26 INFO - Return code: 0 02:57:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:26 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:57:26 INFO - Using env: {'DISPLAY': ':0', 02:57:26 INFO - 'HOME': '/home/cltbld', 02:57:26 INFO - 'LANG': 'en_US.UTF-8', 02:57:26 INFO - 'LANGUAGE': 'en_US:en', 02:57:26 INFO - 'LOGNAME': 'cltbld', 02:57:26 INFO - 'MAIL': '/var/mail/cltbld', 02:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:26 INFO - 'MOZ_NO_REMOTE': '1', 02:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:26 INFO - 'NO_EM_RESTART': '1', 02:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:26 INFO - 'PWD': '/builds/slave/test', 02:57:26 INFO - 'SHELL': '/bin/bash', 02:57:26 INFO - 'SHLVL': '1', 02:57:26 INFO - 'TERM': 'linux', 02:57:26 INFO - 'TMOUT': '86400', 02:57:26 INFO - 'USER': 'cltbld', 02:57:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:26 INFO - '_': '/tools/buildbot/bin/python'} 02:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:57: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 02:57: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 02:57: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 02:57: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 02:57:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57: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 02:57: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 02:57: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 02:57: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 02:57:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:27 INFO - warning: no files found matching '*.txt' 02:57:27 INFO - no previously-included directories found matching 'build' 02:57:27 INFO - no previously-included directories found matching 'dist' 02:57:27 INFO - no previously-included directories found matching '.git*' 02:57:27 INFO - Installing collected packages: jsonschema, functools32 02:57:27 INFO - Running setup.py install for functools32 02:57:27 INFO - warning: no files found matching '*.txt' 02:57:27 INFO - no previously-included directories found matching 'build' 02:57:27 INFO - no previously-included directories found matching 'dist' 02:57:27 INFO - no previously-included directories found matching '.git*' 02:57:27 INFO - Successfully installed jsonschema functools32 02:57:27 INFO - Cleaning up... 02:57:27 INFO - Return code: 0 02:57:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:28 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:57:28 INFO - Using env: {'DISPLAY': ':0', 02:57:28 INFO - 'HOME': '/home/cltbld', 02:57:28 INFO - 'LANG': 'en_US.UTF-8', 02:57:28 INFO - 'LANGUAGE': 'en_US:en', 02:57:28 INFO - 'LOGNAME': 'cltbld', 02:57:28 INFO - 'MAIL': '/var/mail/cltbld', 02:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:28 INFO - 'MOZ_NO_REMOTE': '1', 02:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:28 INFO - 'NO_EM_RESTART': '1', 02:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:28 INFO - 'PWD': '/builds/slave/test', 02:57:28 INFO - 'SHELL': '/bin/bash', 02:57:28 INFO - 'SHLVL': '1', 02:57:28 INFO - 'TERM': 'linux', 02:57:28 INFO - 'TMOUT': '86400', 02:57:28 INFO - 'USER': 'cltbld', 02:57:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:28 INFO - '_': '/tools/buildbot/bin/python'} 02:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:28 INFO - Cleaning up... 02:57:28 INFO - Return code: 0 02:57:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:28 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:57:28 INFO - Using env: {'DISPLAY': ':0', 02:57:28 INFO - 'HOME': '/home/cltbld', 02:57:28 INFO - 'LANG': 'en_US.UTF-8', 02:57:28 INFO - 'LANGUAGE': 'en_US:en', 02:57:28 INFO - 'LOGNAME': 'cltbld', 02:57:28 INFO - 'MAIL': '/var/mail/cltbld', 02:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:28 INFO - 'MOZ_NO_REMOTE': '1', 02:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:28 INFO - 'NO_EM_RESTART': '1', 02:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:28 INFO - 'PWD': '/builds/slave/test', 02:57:28 INFO - 'SHELL': '/bin/bash', 02:57:28 INFO - 'SHLVL': '1', 02:57:28 INFO - 'TERM': 'linux', 02:57:28 INFO - 'TMOUT': '86400', 02:57:28 INFO - 'USER': 'cltbld', 02:57:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:28 INFO - '_': '/tools/buildbot/bin/python'} 02:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:30 INFO - Downloading docopt-0.6.1.tar.gz 02:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:30 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:30 INFO - Running setup.py install for blobuploader 02:57:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:30 INFO - Running setup.py install for requests 02:57:30 INFO - Running setup.py install for docopt 02:57:30 INFO - Successfully installed blobuploader requests docopt 02:57:30 INFO - Cleaning up... 02:57:30 INFO - Return code: 0 02:57:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:30 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:30 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:57:30 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:57:30 INFO - Using env: {'DISPLAY': ':0', 02:57:30 INFO - 'HOME': '/home/cltbld', 02:57:30 INFO - 'LANG': 'en_US.UTF-8', 02:57:30 INFO - 'LANGUAGE': 'en_US:en', 02:57:30 INFO - 'LOGNAME': 'cltbld', 02:57:30 INFO - 'MAIL': '/var/mail/cltbld', 02:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:30 INFO - 'MOZ_NO_REMOTE': '1', 02:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:30 INFO - 'NO_EM_RESTART': '1', 02:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:30 INFO - 'PWD': '/builds/slave/test', 02:57:30 INFO - 'SHELL': '/bin/bash', 02:57:30 INFO - 'SHLVL': '1', 02:57:30 INFO - 'TERM': 'linux', 02:57:30 INFO - 'TMOUT': '86400', 02:57:30 INFO - 'USER': 'cltbld', 02:57:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:30 INFO - '_': '/tools/buildbot/bin/python'} 02:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:30 INFO - Running setup.py (path:/tmp/pip-6iwwOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:31 INFO - Running setup.py (path:/tmp/pip-GQj1ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:31 INFO - Running setup.py (path:/tmp/pip-mpjeMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:31 INFO - Running setup.py (path:/tmp/pip-wzG1Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:31 INFO - Running setup.py (path:/tmp/pip-5Snmyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:31 INFO - Running setup.py (path:/tmp/pip-T_ibYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:31 INFO - Running setup.py (path:/tmp/pip-ZI0Ojo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:31 INFO - Running setup.py (path:/tmp/pip-6tTsxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:31 INFO - Running setup.py (path:/tmp/pip-vuUoPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:31 INFO - Running setup.py (path:/tmp/pip-AWIexj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:31 INFO - Running setup.py (path:/tmp/pip-Te0piz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:31 INFO - Running setup.py (path:/tmp/pip-n9ot9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:31 INFO - Running setup.py (path:/tmp/pip-MTWUsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:31 INFO - Running setup.py (path:/tmp/pip-dBU2TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:31 INFO - Running setup.py (path:/tmp/pip-rqXVu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:32 INFO - Running setup.py (path:/tmp/pip-KoCYo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:32 INFO - Running setup.py (path:/tmp/pip-NGhMtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:32 INFO - Running setup.py install for manifestparser 02:57:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Running setup.py install for mozcrash 02:57:32 INFO - Running setup.py install for mozdebug 02:57:32 INFO - Running setup.py install for mozdevice 02:57:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Running setup.py install for mozfile 02:57:32 INFO - Running setup.py install for mozhttpd 02:57:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Running setup.py install for mozinfo 02:57:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Running setup.py install for mozInstall 02:57:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:32 INFO - Running setup.py install for mozleak 02:57:33 INFO - Running setup.py install for mozlog 02:57:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Running setup.py install for moznetwork 02:57:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Running setup.py install for mozprocess 02:57:33 INFO - Running setup.py install for mozprofile 02:57:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Running setup.py install for mozrunner 02:57:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Running setup.py install for mozscreenshot 02:57:33 INFO - Running setup.py install for moztest 02:57:33 INFO - Running setup.py install for mozversion 02:57:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:33 INFO - Cleaning up... 02:57:33 INFO - Return code: 0 02:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57: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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57: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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:57: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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:57:33 INFO - Using env: {'DISPLAY': ':0', 02:57:33 INFO - 'HOME': '/home/cltbld', 02:57:33 INFO - 'LANG': 'en_US.UTF-8', 02:57:33 INFO - 'LANGUAGE': 'en_US:en', 02:57:33 INFO - 'LOGNAME': 'cltbld', 02:57:33 INFO - 'MAIL': '/var/mail/cltbld', 02:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:33 INFO - 'MOZ_NO_REMOTE': '1', 02:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:33 INFO - 'NO_EM_RESTART': '1', 02:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:33 INFO - 'PWD': '/builds/slave/test', 02:57:33 INFO - 'SHELL': '/bin/bash', 02:57:33 INFO - 'SHLVL': '1', 02:57:33 INFO - 'TERM': 'linux', 02:57:33 INFO - 'TMOUT': '86400', 02:57:33 INFO - 'USER': 'cltbld', 02:57:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:33 INFO - '_': '/tools/buildbot/bin/python'} 02:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:34 INFO - Running setup.py (path:/tmp/pip-LmsKwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:34 INFO - Running setup.py (path:/tmp/pip-4j_QCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:34 INFO - Running setup.py (path:/tmp/pip-cv9Q5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:34 INFO - Running setup.py (path:/tmp/pip-n_zPmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:34 INFO - Running setup.py (path:/tmp/pip-uWaugB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57: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)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:34 INFO - Running setup.py (path:/tmp/pip-hNmchM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57: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)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:34 INFO - Running setup.py (path:/tmp/pip-fRJGI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:34 INFO - Running setup.py (path:/tmp/pip-q3Qrsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:34 INFO - Running setup.py (path:/tmp/pip-qqsAlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57: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)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:34 INFO - Running setup.py (path:/tmp/pip-EIgo7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:34 INFO - Running setup.py (path:/tmp/pip-cKQpG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57: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)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:34 INFO - Running setup.py (path:/tmp/pip-fZGayC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57: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)) 02:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:35 INFO - Running setup.py (path:/tmp/pip-NFCn4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57: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)) 02:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:35 INFO - Running setup.py (path:/tmp/pip-UOmNzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57: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)) 02:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:35 INFO - Running setup.py (path:/tmp/pip-dWM53t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57: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)) 02:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:35 INFO - Running setup.py (path:/tmp/pip-Dkoz_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57: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)) 02:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:35 INFO - Running setup.py (path:/tmp/pip-6pDBle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57: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)) 02:57: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)) 02:57: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)) 02:57: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)) 02:57: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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57: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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:57:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57: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 02:57: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 02:57: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 02:57: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 02:57:36 INFO - Downloading blessings-1.6.tar.gz 02:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:36 INFO - Installing collected packages: blessings 02:57:36 INFO - Running setup.py install for blessings 02:57:36 INFO - Successfully installed blessings 02:57:36 INFO - Cleaning up... 02:57:36 INFO - Return code: 0 02:57:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:36 INFO - Reading from file tmpfile_stdout 02:57:36 INFO - Current package versions: 02:57:36 INFO - argparse == 1.2.1 02:57:36 INFO - blessings == 1.6 02:57:36 INFO - blobuploader == 1.2.4 02:57:36 INFO - docopt == 0.6.1 02:57:36 INFO - functools32 == 3.2.3-2 02:57:36 INFO - jsonschema == 2.5.1 02:57:36 INFO - manifestparser == 1.1 02:57:36 INFO - mozInstall == 1.13 02:57:36 INFO - mozcrash == 1.0 02:57:36 INFO - mozdebug == 0.1 02:57:36 INFO - mozdevice == 0.51 02:57:36 INFO - mozfile == 1.2 02:57:36 INFO - mozhttpd == 0.7 02:57:36 INFO - mozinfo == 0.10 02:57:36 INFO - mozleak == 0.1 02:57:36 INFO - mozlog == 3.5 02:57:36 INFO - moznetwork == 0.27 02:57:36 INFO - mozprocess == 0.25 02:57:36 INFO - mozprofile == 0.28 02:57:36 INFO - mozrunner == 6.13 02:57:36 INFO - mozscreenshot == 0.1 02:57:36 INFO - mozsystemmonitor == 0.3 02:57:36 INFO - moztest == 0.8 02:57:36 INFO - mozversion == 1.4 02:57:36 INFO - psutil == 3.1.1 02:57:36 INFO - requests == 1.2.3 02:57:36 INFO - wsgiref == 0.1.2 02:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:36 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:36 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:57:36 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:57:36 INFO - Using env: {'DISPLAY': ':0', 02:57:36 INFO - 'HOME': '/home/cltbld', 02:57:36 INFO - 'LANG': 'en_US.UTF-8', 02:57:36 INFO - 'LANGUAGE': 'en_US:en', 02:57:36 INFO - 'LOGNAME': 'cltbld', 02:57:36 INFO - 'MAIL': '/var/mail/cltbld', 02:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:36 INFO - 'MOZ_NO_REMOTE': '1', 02:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:36 INFO - 'NO_EM_RESTART': '1', 02:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:36 INFO - 'PWD': '/builds/slave/test', 02:57:36 INFO - 'SHELL': '/bin/bash', 02:57:36 INFO - 'SHLVL': '1', 02:57:36 INFO - 'TERM': 'linux', 02:57:36 INFO - 'TMOUT': '86400', 02:57:36 INFO - 'USER': 'cltbld', 02:57:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:36 INFO - '_': '/tools/buildbot/bin/python'} 02:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:57:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:57: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)) 02:57: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)) 02:57:38 INFO - Installing collected packages: simplejson 02:57:38 INFO - Running setup.py install for simplejson 02:57:38 INFO - building 'simplejson._speedups' extension 02:57:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:57:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:57:39 INFO - Successfully installed simplejson 02:57:39 INFO - Cleaning up... 02:57:39 INFO - Return code: 0 02:57:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:39 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/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 0x25561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:57:39 INFO - Using env: {'DISPLAY': ':0', 02:57:39 INFO - 'HOME': '/home/cltbld', 02:57:39 INFO - 'LANG': 'en_US.UTF-8', 02:57:39 INFO - 'LANGUAGE': 'en_US:en', 02:57:39 INFO - 'LOGNAME': 'cltbld', 02:57:39 INFO - 'MAIL': '/var/mail/cltbld', 02:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:39 INFO - 'MOZ_NO_REMOTE': '1', 02:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:39 INFO - 'NO_EM_RESTART': '1', 02:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:39 INFO - 'PWD': '/builds/slave/test', 02:57:39 INFO - 'SHELL': '/bin/bash', 02:57:39 INFO - 'SHLVL': '1', 02:57:39 INFO - 'TERM': 'linux', 02:57:39 INFO - 'TMOUT': '86400', 02:57:39 INFO - 'USER': 'cltbld', 02:57:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:39 INFO - '_': '/tools/buildbot/bin/python'} 02:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:39 INFO - Cleaning up... 02:57:39 INFO - Return code: 0 02:57:39 INFO - Running post-action listener: _resource_record_post_action 02:57:39 INFO - Running post-action listener: _start_resource_monitoring 02:57:39 INFO - Starting resource monitoring. 02:57:39 INFO - [mozharness: 2017-09-02 09:57:39.588550Z] Finished create-virtualenv step (success) 02:57:39 INFO - [mozharness: 2017-09-02 09:57:39.589138Z] Running install step. 02:57:39 INFO - Running pre-action listener: _resource_record_pre_action 02:57:39 INFO - Running main action method: install 02:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:39 INFO - Reading from file tmpfile_stdout 02:57:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:57:39 INFO - Reading from file tmpfile_stdout 02:57:39 INFO - Output received: 02:57:39 INFO - Usage: mozinstall [options] installer 02:57:39 INFO - Options: 02:57:39 INFO - -h, --help show this help message and exit 02:57:39 INFO - -d DEST, --destination=DEST 02:57:39 INFO - Directory to install application into. [default: 02:57:39 INFO - "/builds/slave/test"] 02:57:39 INFO - --app=APP Application being installed. [default: firefox] 02:57:39 INFO - mkdir: /builds/slave/test/build/application 02:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:57:56 INFO - Reading from file tmpfile_stdout 02:57:56 INFO - Output received: 02:57:56 INFO - /builds/slave/test/build/application/firefox/firefox 02:57:56 INFO - Running post-action listener: _resource_record_post_action 02:57:56 INFO - [mozharness: 2017-09-02 09:57:56.450031Z] Finished install step (success) 02:57:56 INFO - [mozharness: 2017-09-02 09:57:56.450254Z] Running setup-mitmproxy step. 02:57:56 INFO - Running pre-action listener: _resource_record_pre_action 02:57:56 INFO - Running main action method: setup_mitmproxy 02:57:56 INFO - Skipping: mitmproxy is not required 02:57:56 INFO - Running post-action listener: _resource_record_post_action 02:57:56 INFO - [mozharness: 2017-09-02 09:57:56.450799Z] Finished setup-mitmproxy step (success) 02:57:56 INFO - [mozharness: 2017-09-02 09:57:56.450901Z] Running run-tests step. 02:57:56 INFO - Running pre-action listener: _resource_record_pre_action 02:57:56 INFO - Running pre-action listener: _set_gcov_prefix 02:57:56 INFO - Running main action method: run_tests 02:57:56 WARNING - Try message not found. 02:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:57:56 INFO - Python 2.7.3 02:57:56 INFO - Return code: 0 02:57:56 INFO - grabbing minidump binary from tooltool 02:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/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 0x28c6090>, '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 0x28c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:57:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:57:56 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:57:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:57:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:57:56 INFO - Return code: 0 02:57:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:57:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:57:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:57:56 INFO - ENV: RUST_BACKTRACE is now full 02:57:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:57:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:57:56 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:57:56 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/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:57:56 INFO - Using env: {'DISPLAY': ':0', 02:57:56 INFO - 'HOME': '/home/cltbld', 02:57:56 INFO - 'LANG': 'en_US.UTF-8', 02:57:56 INFO - 'LANGUAGE': 'en_US:en', 02:57:56 INFO - 'LOGNAME': 'cltbld', 02:57:56 INFO - 'MAIL': '/var/mail/cltbld', 02:57:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:56 INFO - 'MOZ_ACCELERATED': '1', 02:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:56 INFO - 'MOZ_NO_REMOTE': '1', 02:57:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:56 INFO - 'MOZ_WEBRENDER': '1', 02:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:56 INFO - 'NO_EM_RESTART': '1', 02:57:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:56 INFO - 'PWD': '/builds/slave/test', 02:57:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:56 INFO - 'RUST_BACKTRACE': 'full', 02:57:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:57:56 INFO - 'SHELL': '/bin/bash', 02:57:56 INFO - 'SHLVL': '1', 02:57:56 INFO - 'TERM': 'linux', 02:57:56 INFO - 'TMOUT': '86400', 02:57:56 INFO - 'USER': 'cltbld', 02:57:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:56 INFO - '_': '/tools/buildbot/bin/python'} 02:57:56 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:57:56 INFO - mozversion application_buildid: 20170902085613 02:57:56 INFO - mozversion application_changeset: a46a5879b8781ae9ea99f37b5d34a891f0f75047 02:57:56 INFO - mozversion application_display_name: Nightly 02:57:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:57:56 INFO - mozversion application_name: Firefox 02:57:56 INFO - mozversion application_remotingname: firefox 02:57:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:57:56 INFO - mozversion application_vendor: Mozilla 02:57:56 INFO - mozversion application_version: 57.0a1 02:57:56 INFO - mozversion platform_buildid: 20170902085613 02:57:56 INFO - mozversion platform_changeset: a46a5879b8781ae9ea99f37b5d34a891f0f75047 02:57:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:57:56 INFO - mozversion platform_version: 57.0a1 02:57:56 INFO - using testdate: 1504346276 02:57:56 INFO - actual date: 1504346276 02:57:56 INFO - starting webserver on 'localhost:34575' 02:57:56 INFO - SUITE-START | Running 2 tests 02:57:56 INFO - TEST-START | dromaeo_css 02:57:56 INFO - Initialising browser for dromaeo_css test... 02:57:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34575/getInfo.html -profile /tmp/tmptlFFh3/profile 02:57:56 INFO - TEST-INFO | started process 7517 (/builds/slave/test/build/application/firefox/firefox http://localhost:34575/getInfo.html) 02:58:03 INFO - TEST-INFO | 7517: exit 0 02:58:03 INFO - Browser initialized. 02:58:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:03 INFO - Using env: {'DISPLAY': ':0', 02:58:03 INFO - 'HOME': '/home/cltbld', 02:58:03 INFO - 'JSGC_DISABLE_POISONING': '1', 02:58:03 INFO - 'LANG': 'en_US.UTF-8', 02:58:03 INFO - 'LANGUAGE': 'en_US:en', 02:58:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:58:03 INFO - 'LOGNAME': 'cltbld', 02:58:03 INFO - 'MAIL': '/var/mail/cltbld', 02:58:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:03 INFO - 'MOZ_ACCELERATED': '1', 02:58:03 INFO - 'MOZ_CRASHREPORTER': '1', 02:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:58:03 INFO - 'MOZ_NO_REMOTE': '1', 02:58:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:03 INFO - 'MOZ_WEBRENDER': '1', 02:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:03 INFO - 'NO_EM_RESTART': '1', 02:58:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:03 INFO - 'PWD': '/builds/slave/test', 02:58:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:03 INFO - 'RUST_BACKTRACE': 'full', 02:58:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:58:03 INFO - 'SHELL': '/bin/bash', 02:58:03 INFO - 'SHLVL': '1', 02:58:03 INFO - 'TERM': 'linux', 02:58:03 INFO - 'TMOUT': '86400', 02:58:03 INFO - 'USER': 'cltbld', 02:58:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 02:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:03 INFO - '_': '/tools/buildbot/bin/python'} 02:58:03 INFO - TEST-INFO | started process 7712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptlFFh3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:04 INFO - PID 7712 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:58:04 INFO - PID 7712 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:58:04 INFO - PID 7712 | 02:58:04 INFO - PID 7712 | (/builds/slave/test/build/application/firefox/firefox:7774): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:58:04 INFO - PID 7712 | 02:58:15 INFO - PID 7712 | RSS: Main: 206819328 02:58:15 INFO - PID 7712 | 02:58:18 INFO - PID 7712 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:01:13 INFO - PID 7712 | Cycle 1(1): loaded http://localhost:34575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34575/tests/dromaeo/cssquery-ext.html) 03:01:15 INFO - PID 7712 | RSS: Main: 217862144 03:01:15 INFO - PID 7712 | 03:04:17 INFO - PID 7712 | Cycle 1(1): loaded http://localhost:34575/tests/dromaeo/cssquery-ext.html (next: http://localhost:34575/tests/dromaeo/cssquery-jquery.html) 03:04:18 INFO - PID 7712 | RSS: Main: 215457792 03:04:18 INFO - PID 7712 | 03:07:20 INFO - PID 7712 | Cycle 1(1): loaded http://localhost:34575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34575/tests/dromaeo/cssquery-mootools.html) 03:07:20 INFO - PID 7712 | RSS: Main: 217309184 03:07:20 INFO - PID 7712 | 03:10:22 INFO - PID 7712 | Cycle 1(1): loaded http://localhost:34575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34575/tests/dromaeo/cssquery-prototype.html) 03:10:23 INFO - PID 7712 | RSS: Main: 212623360 03:10:23 INFO - PID 7712 | 03:13:27 INFO - PID 7712 | Cycle 1(1): loaded http://localhost:34575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34575/tests/dromaeo/cssquery-yui.html) 03:13:28 INFO - PID 7712 | RSS: Main: 217432064 03:13:28 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | Cycle 1(1): loaded http://localhost:34575/tests/dromaeo/cssquery-yui.html (next: http://localhost:34575/tests/dromaeo/cssquery-dojo.html) 03:16:30 INFO - PID 7712 | RSS: Main: 220295168 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | __start_tp_report 03:16:30 INFO - PID 7712 | _x_x_mozilla_page_load 03:16:30 INFO - PID 7712 | _x_x_mozilla_page_load_details 03:16:30 INFO - PID 7712 | |i|pagename|runs| 03:16:30 INFO - PID 7712 | |0;dojo.html;3277.688619581139;3337.3992681317354;3339.6326404095544;3351.245969656827;3383.5093911382833;6207;6331.620102793836;6390.8402289942715;6404.775832845851;6429.164208652875;6463.4829213662915;6498.642574658392;6544.640044797547;6552.672366381674;6576.243731970825;5834.912476312858;5872.765089396419;5908.350081491043;5952.851178720523;5981.312149102865;5688.232088668039;5688.516476099537;5791.652500849962;5827.941720582803;5875.383084776101;5814.738336774813;5826.242588463515;5903.586748927577;5910.34986151523;5913.408659134096;5755.913661295084;5846.415358464162;5857.474417656939;5871.677057761822;5913.586048976574;5587.972060139714;5686.3744988051285;5706.457886500776;5773.364929857712;5868.03177475716;6225.688715564203;6228.37716228378;6330.208723909512;6457.773977910751;6459.709313080875;6700.229473610549;6861.965690171517;6876.140482439695;6893.4140598049225;6943.305669433067;6814.62519561424;6897.9655101724675;6901.206361268418;6913.1358580177475;6952.443804495679;6263.906041409383;6311.463525600376;6343.746250150035;6427.87144257117;6520.510961677845;7107.289271072851;7116.644167791694;7121.430285577245;7126.750563730245;7211.350978411968;6724.193096828412;6727.596344219362;6735.595864248161;6777.322267773183;6837.9658101710165;6870.7595234166565;6909.7581584644295;6966.790996270019;6967;6994.265602111806;6692.096566963398;6764.966175169191;6798.8640227196165;6806.421454176351;6819.5908245505425;6719.227288861745;6720.361565651256;6721.1598550181225;6726;6737.292584278678;4921.114199444134;4993.625478089158;4996.775145118479;5002.424721157041;5023.673461225008;4456.3538286948215;4476.261416866246;4523.683342166082;4542.409486766765;4555.020670555847;6015.488683461867;6077.17958075663;6101.115338275925;6152.261728592597;6154.292256390483;6709.630970296583;6916.20463646687;6949.061876646689;6953.061336719579;7016.2632923543315;5879.911801322984;5941.792037278675;6065.999110146865;6110.327863934964;6113.877722445526;5875.324337701134;5886.087656413263;5947.405259474018;5947.9702601486715;5966.880662386728;6808.38724514796;6819;6828.624425656537;6837.1111755471475;6848.897266541006;6711.765088221889;6784.559003664746;6850.588964662136;6913.75801846933;7059.541129826544;6658.43403310724;6669.966650166718;6672.633005184762;6675.799726008033;6698.497612678971;6522.902156467751;6623.536352455282;6686.899696504459;6694.29709880475;6711.899321510279;6807.319268073153;6816.897746533905;6846.075779769667;6853.417459515797;6871.622060786704;5704.714764261853;6700.899486507804;6701.832454188684;6784.321567843176;6788.253292137762;6569.507286953593;6702.262751097278;6708.127943367331;6803.863922721419;6804.863902721819;6442.452391546583;6553.672316384257;6608.933910660832;6623.966880165568;6702.698378572878;6651.667416629246;6660.433863121689;6728.428083612947;6747.190337159573;6747.797566073025;6355.269144048493;6378.394052564999;6381.840453988688;6514.967425162844;6568.113304703804 03:16:30 INFO - PID 7712 | |1;ext.html;780.4146889832625;798.504926945294;821.5892053973014;849.6346570974487;852.0627309959045;38709.80645096774;39030;39225.80387098068;39278.607213927855;39391;35224.471632925524;35499.64500354996;35707.10732231695;35871;36001.27997440056;6737.595744255336;6858;6907.620080895549;6913.723451061952;6920;6769.18769747631;6785.21969973452;7011.859762804741;7690.3078722914925;7718.884216736754;7644.847103057936;7733.149353571102;7758.262965018343;7760.961195194016;7771.067471903351;7675.692972281102;7711.3059824615775;7719.884201736979;7720.189380115091;7745.651445684957;7653.579053152074;7716.074071111502;7725.884111738328;7731.188225236382;7744.49660772048;36104.81947590272;36491.08772280688;36690.633093669254;36713.449298260544;36725.265494690226;3552.662497062775;3560.893173204808;3591.7665351752053;3612.674859262679;3616.65641764032;30270.24324391886;30570.847145764128;30590.08229753111;30650.693493065006;30718;5015.247712843103;5169.844904652867;5195.350581177353;5202.531772140488;5296.285001524783;180429;181459;187990.12009879862;192044;199696.00151999292;48099.27851082237;48242.31151909736;48416.27375589369;48424.757876210395;48571.02857942821;49380.50619493831;49429.25856112161;49440.50559494359;49493.77278022498;49690.75154624276;15390.3074361654;15400.61498462525;15435.768463473058;15464.60818526338;15486.767698484531;12587.244765313928;12649.367531623382;12681.429335679917;12737.29944853042;12794.424250908545;13722.588322350346;14039.50861719835;14040.929795350958;14041.297935103408;14144.292785360896;5501.394846566875;5662.17898404729;5688.260526131577;5719.512012274674;5833.38749431312;1008.3193844155165;1016.5628779624832;1022.9079382855579;1023.5956797065118;1029.0789743179812;22549.323520294416;22559.210427634953;22725.659115113285;22760.20339288117;22990.310290691305;1085.5115198160859;1106.9428695595686;1111.0112000319723;1117.6702872652586;1124.150279042623;12319.507219711291;12384.690382740324;12420.130590858553;12448.502059917682;12560.434780434902;226320;229367;230032;230435;230650;50526.98946021059;50536.49463505392;50767.74616126969;50972;50999.49000510022;1414.4625042483997;1429.428228708525;1432.1264028942337;1451.3468938977715;1452.3899962015978;22458;22539.436514086625;22554;22685;22775.316740497812;36044.45933311055;36287;36336.27327453489;36443.27113457769;36545.45181822328;201526;202645;202752;203069;203147;33378.66621333756;35085.82457087698;36674.44988325231;36731.63268367282;36797.81601091977;44067.55932440634;44982.325265121704;45336;45368;45911.77044114758;32958;33436.498452523716;33510;33558;33804.3239135211;33323.50014749829;33654;34896.65103349036;35423.64576354204;35445.29109417849;37435.43846842354;38368.80815595904;38498;39095.218095637356;39327.80336098301;39305.606943931336;39388;39684.2063158741;40134.79932600318;40151.1969760609;29264.56103158412;29443.85278073596;29640.703592963793;30484.847575761978;30491.542626861057 03:16:30 INFO - PID 7712 | |2;jquery.html;563.2733773432273;564.8700798816272;566.4363957861925;572.3875453265006;576.4955663794182;21161.894190529045;22189.667154992687;22269.997850096763;22329.218477353297;22330.88834555827;24024.639630405556;25825.48349033023;26088.47823043538;26277.34306642335;26374.86812565939;6352.84117897054;6520.836979075538;6530;6534.477241820643;6548.345165483437;6382.042693595951;6412.967935160341;6421.165248517686;6423.614583125028;6427.678616069201;5712.400197979194;6276.372362763733;6305.842353941165;6316.778912738055;6349.333320001402;6263.812085637438;6273.090401891723;6276.466500347453;6334.524910631675;6347.111404403341;5821.53427725781;5856.121581762727;5873.471387575139;5888.617239879437;5899.439553242435;28375.432491350264;28857.56713649297;29061.564076538867;29369.706302937124;29457.852710736308;2058.9485262868398;2100.978990210109;2108.630989576818;2123.055240418015;2129.0525716056363;18452.815471845242;19010.904945475322;19095.90452047731;19130.33043843473;19231.615367692706;2357.233898982837;2366.408397900525;2420.068273714615;2423.987880060606;2449.8775061246865;126423;128832;128952;129030;129245;13772;14031.78952315716;14193.219372934382;14681.19253441071;14699.485518007032;22472.101115955506;22542.436439089153;22615.208467703553;22686.319410417713;22833.657495137588;9718.271129665303;9923.603055877684;9960.701178964642;10032.64885728996;10095.7476063099;9155.992840787641;9236.214921731727;9294.676330917271;9311.463608504657;9426.387284826464;8436.325093992466;8760.342974276828;8778.166074222938;8832.8675069874;8848.646054157762;2645.4444566641223;2737.7262273772462;2766.806323557332;2797.4964506389047;2905.5932169496286;933.3653115881266;955.9713208603753;956.7464621875208;983.7245571240064;985.5072463768116;20030.298939537046;20567.280145195145;20698.68951965722;20757.962101894846;20874.895625521774;1027.8869324374314;1039.1790485516508;1044.8484969679505;1048.5700862646431;1058.767071244325;11225.382603956861;11261.66215013551;11302;11330.37682927447;11539.538418463168;428272;429002;434909;437842;438477;112177;113653;113816;114447;117587.41206293914;1173.5481839491856;1189.3102000839492;1189.8512685914088;1190.827330037157;1204.1450570095155;18472;18525.166367513764;18551.07244637736;18740.437786866416;19012.239510419982;56460.71769641126;57847;58017.419825801204;58085.70957145356;58567.414325856196;71771.64114179605;71896.28103718896;72265;72347.27652723405;73517.63241183759;12140.635780926586;14389.280535973368;14626;14666.193359365338;14744;18477;22592.209272675376;23258.651120232873;23519.176828811593;24073.157439489532;18406.723899141256;18456.26174952987;18494.0752962354;18556.350527731465;18612.44162675122;16024.359025638843;16554.751678724588;16717.74923376126;16780;16947;18462.261509540007;18788.624227515647;18910.810891890906;19085.236590536224;19320.71018934689;14105.083169593943;14152.716945661236;14162.575122746333;14247.71504569882;14366.13803171813;18141.27434902589;18251.726224106384;18342.724859126858;18420;18707 03:16:30 INFO - PID 7712 | |3;mootools.html;1332.7401156774429;1397.9510717124904;1406.430395689746;1415.4621243927306;1415.5187236339646;12724.172928759624;14838.40646374145;15378.846211537895;15426.768598471032;15429.845701542981;12726.172798768097;15286.84713152868;15858.603534911634;15874.365025399;15889.841101588981;2699.7705195058443;2740.0957683964343;2746.436980419019;2746.8489233092273;2751.3671855473153;2591.883365248559;2725.945481090377;2727.9181624551197;2732.4261904999976;2734.507788598052;2586.237060067285;2695.0567301444535;2765.7096004919495;2775.2090654163567;2781.2629653141935;2780.3605170810724;2812.395335002984;2841.076650088709;2855.4003659231585;2860.4994126027964;2768.1557125076843;2773.611694362791;2793.6368272124696;2795.55271156616;2808.7893407994484;14540.491082812157;14867.851321486754;14994.325255363536;15019.173945432996;15103.32035058414;7939.28546430824;8161.183881611851;8176.877346839802;8241.269333439985;8283.17168283173;5242.659227150261;5323.494268044529;5483.287172667528;5523.392426833045;5636.971815140939;1888.5184278009158;1900.5438694713307;1913.5311848597044;1960.0689672405636;1963.577830766392;25751.742482575122;27237.863810681018;27271.86364068187;27357.726422735715;27475.450490990068;6775.525713200127;6831.521793474509;6924.93075069253;6975.965120174468;7160.391366733782;16906.830931690773;16943.576410589587;16951.40670076566;16957.40649077301;16994.235259413355;7772.106207786177;7924.603769811486;7959.9602001989615;7964.601769911481;7966.84066318682;7213.71145154188;7297.525660832029;7422.369098626677;7565.583892885944;7667.233276672288;4995;5189.636725429259;5201.349831271091;5244.5542128918705;5297.443768404339;1542.706885691715;1549.4654344251214;1551.4724993502264;1563.6794457136486;1577.4873166221023;879.6261588824724;898.7438580004667;909.9545022748836;917.1058218237165;931.8835145606799;7553.584552849646;7554.169041405441;7571;7669.808254793675;7698.230176982257;718.547315191426;730.9693332401289;962.8411312133419;1017.531935309751;1020.9336393134422;5110.4634013428795;5164.406093299319;5220.321358223483;5231.476852314738;5334.226537152092;21483.14067437285;22400.215992440186;22402.663960040612;22598.887005564866;22606.434839129153;21317.25389611356;21722.674159887614;21912.780872191073;21974.121035158736;22053.22813701513;10659.84010239847;10993.61522346714;10997.890021099847;11071.612493562849;11092.944535277433;7671.462997590115;7795.649195786316;7944.285014348737;7994.880076798736;8024.0772311184965;17676.558086047953;18468;18483.445496635122;18667;18705.25178992825;18824.717629235845;18877.71683424777;18951.715724264424;19102.140403682144;19199.712004320227;11144.944275278573;11300.321980680857;11327.546898124312;11352.205345625727;11356.148288878532;14018.789718154032;14094.718105637625;14134.293285335487;14228.786568201278;14238.786418203943;10664.84002739975;10935.343879367263;10963.177761668067;11083.612073577386;11100;11164.944175279397;11207.10343172528;11220;11321.924417180355;11384.886151138382;9699;9726.902730972883;9741.902580974383;9814.214862810815;9900.158486528726;6896.413804826646;6906.723731050903;7064.894026589503;7079.910977155527;7163.06880105583;6770.526063175727;6923.792286231421;6972.988916607165;6994.720211191496;7056.82357941035 03:16:30 INFO - PID 7712 | |4;prototype.html;500.62703286051897;501.7081016382815;521.642674767784;530.2682298428168;530.4617405713661;6256.499480041597;6341.365863413656;6359.282993591727;6362.204724409449;6379.744810207592;6155.692215389235;6195.2565692117005;6255.2806427260875;6262.185915830947;6277.152584401116;5004.724740139291;5007.649464537484;5031.52200540948;5039.269305950654;5125.589952803785;4877.34155888954;5007.974960125212;5037.204351584869;5077.162268225738;5102.336696229485;4934.830068592034;4981.203007518798;4991.126552853254;5055.9747201263945;5120.795168193268;4955.752212389366;4989.226669866177;5019.372578427697;5054.028928717767;5079.7714102865275;4484.260097083978;4503.954960450386;4506.459224893001;4512.12013657337;4540.591346778772;6055.727492262815;6183.690815459254;6194.938050619527;6211.260846962858;6214.254289485246;5658.858528536778;5787.797427090074;5796.8840623187725;5805.129230615399;5807.128930660392;6609.239937407212;6666.866632672409;6667.666616669196;6685.331466853324;6707.411534828843;4740.360051393087;4852.272159176152;4891.095147397743;4924.876878078041;4937.530934561211;6843;6883.27725588816;6982.47631427645;7039.507234493588;7100.680469378839;4990.251462280615;5007.624428167902;5058.595312375001;5059.645824792229;5083.38999320084;5034.194528875362;5053.797848086036;5116.846494605168;5117.206832940826;5176.7152806596;5726.198332233491;5747.3103227612955;5773.855653608609;5778.88442231153;5791.623544469596;6679.365460281266;6728.2809611830535;6734.56225345351;6754.5609535380045;6806.217285012287;1660.5433505786004;1669.2071266148725;1684.89890606564;1698.3970690404728;1759.8416142547233;1191.2852288626755;1220.8473940757406;1221.7251118498446;1222.4010234984794;1240.683625675447;5667.4615911488345;5794.536437085023;5831.620944638585;5852.385499522574;5919.378465261172;6609.537332386687;6643.5017373697165;6677.3656502632175;6686.759935421591;6713.932860671429;5701.686407247558;5769.1923130761725;5821.912671309934;5825.825225243249;5891.882162356729;3508.3509550733197;3544;3547.2728090741334;3562.2163124112653;3568.197155640012;6406.199225096863;6480.57876238043;6500.317466666026;6505.902411463831;6592.604443733391;6767.729290828312;6774.187097548227;6789.830254243683;6791.72833086671;6797.0628370914055;6415.235810152152;6473.287938326875;6499.512536559777;6510.511711621647;6530.346965303622;6545.345465453607;6584.374484423972;6631.403173714196;6636.2368327642935;6669.666516674244;6448.871022579616;6498.707558159988;6522.739090436519;6525.608463492205;6537.019447082976;6383.297837237993;6393.6163830170335;6411.903821442776;6415.807525774234;6452.612843229421;4834.492378300228;4866.318715379779;4869.586085182799;4876.658633895593;4888.560029597354;6469.867773139776;6547.345265473415;6625.768098116543;6648.634325112165;6698.7320507179165;6236.251649802053;6262.592931459622;6321.589096708699;6335.271443784024;6392.648404337806;6021.638701677914;6293.307736149111;6425.915560531064;6563.146790917151;6574.243961944247;6421.389967953037;6490.967545162244;6542.738290468328;6588.110605068255;6595.274519802914;6587.176602924635;6609.173853268341;6614.404703576702;6616.172978377703;6635.601863888182;6141.324454309933;6293.748250069946;6337.334579869232;6339.1125242467015;6407.231132264158 03:16:30 INFO - PID 7712 | |5;yui.html;898.4743924803988;899.7300809757076;911.4804561400005;915.6612053540191;915.8580420034897;17227;17502.82497175028;17520.82479175208;17640.117994100307;17680.73478897816;19622.901885490588;20217.393478195678;20251.189952401925;20314.08586613602;20422;988.1403179234077;1000.3397757480064;1000.4597517340627;1002.4536627537973;1008.2790804574728;906.6735975048977;992.1814503034989;997.7755005123862;1013.3058854684565;1014.2646581228624;1035.1201478743083;1051.148569658579;1052.1267348101057;1053.0785562632695;1053.536443964653;1045.4354648489807;1048.2138396202847;1051.2903789941759;1051.621416290135;1051.9421431821247;772.3898120484811;772.5905270206799;772.9536227826292;773.1649818196335;774.8024253815297;19332.516687082796;19431.319903803298;19464.610707785763;19520.414387568395;20860.47848803777;21012.369628911158;21154.682679759815;21355.78644213569;21615.243466478754;21682.674759878613;16307.592310192222;16775.2451139699;16814.32742690291;16876.493705188863;16896.324147034225;3654.8172591370326;3690.3541880171133;3694.11341278094;3736.3648179809225;3747.0445036515785;126019.3699031499;126470.36764816118;126760;128289;129409;15479.767803482957;15574.143422111665;15933.681326373408;15937.920310398606;16316.592085197728;28998.855005725258;30135.547966780516;30191;30416;30655.69344306573;8608.913910860936;8672.739817805475;8715.564221788885;8745.475271483605;8791.648334066693;4140.4617399738445;4208.6633069354375;4227.260229459832;4232.978835105805;4247.787610619456;5798.88402231953;6075.179850720185;6127.571070025056;6140;6156.846078848064;1162.2096974057554;1192.8389667394965;1211.9697007574705;1212.927224366541;1214.5263347294563;674.9763758268437;679.4835924697265;702.0942983551162;702.2661318921739;708.8582283543209;11631.825522617168;12220.594631617478;12244.81632775509;12698.11113222084;12960.157589756636;663.9269680335159;691.8097523181065;701.5229643842237;718.5939943931662;722.3354513847273;5445.210444485528;5661;5748.367679555246;5779.306483221956;5816;105980.1459155596;106557.46721266344;107399.38900916492;107610;108832;97578.512107439;97957;98863.50568247112;100196.49901750445;104503;83876.16123838683;84413.15586844175;85270;85372;88665.55667221623;10534.262601617813;10630.043296103388;10647.840282395926;10764.3541387517;10835.187360948117;39545.406818898315;39862.40206396848;40718.38922416107;40972.3854142194;41121;51467;51890.74054629703;53803.19295210653;53979.73010134924;68965.65517172382;15850.920745396199;16488.422905198262;16504.00975941447;16735.832641673915;18637.81362186415;17759.644807104043;18830;19238.61522769509;19789;21336;19376.61246775085;19483.61032779308;19513;19795.901020494806;19976.70034949506;18427.447176584723;19071.713924291424;19132.617347653246;19375.709364359827;19441.61116777685;18079.096045197424;18380.724289135407;18881.622367552296;19300.22799088021;19539.120739566468;13433.596992090253;13916.095453795471;14317;14432.927835360755;14507.854921450651;14060.859391406364;14173.929130354281;14228.146311220946;14246.928765356108;15573 03:16:30 INFO - PID 7712 | __end_tp_report 03:16:30 INFO - PID 7712 | __start_cc_report 03:16:30 INFO - PID 7712 | _x_x_mozilla_cycle_collect,371 03:16:30 INFO - PID 7712 | __end_cc_report 03:16:30 INFO - PID 7712 | __startTimestamp1504347390658__endTimestamp 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | ------- Summary: start ------- 03:16:30 INFO - PID 7712 | Number of tests: 6 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | [#0] dojo.html Cycles:165 Average:6286.36 Median:6568.11 stddev:778.50 (11.9%) stddev-sans-first:744.25 03:16:30 INFO - PID 7712 | Values: 3277.7 3337.4 3339.6 3351.2 3383.5 6207.0 6331.6 6390.8 6404.8 6429.2 6463.5 6498.6 6544.6 6552.7 6576.2 5834.9 5872.8 5908.4 5952.9 5981.3 5688.2 5688.5 5791.7 5827.9 5875.4 5814.7 5826.2 5903.6 5910.3 5913.4 5755.9 5846.4 5857.5 5871.7 5913.6 5588.0 5686.4 5706.5 5773.4 5868.0 6225.7 6228.4 6330.2 6457.8 6459.7 6700.2 6862.0 6876.1 6893.4 6943.3 6814.6 6898.0 6901.2 6913.1 6952.4 6263.9 6311.5 6343.7 6427.9 6520.5 7107.3 7116.6 7121.4 7126.8 7211.4 6724.2 6727.6 6735.6 6777.3 6838.0 6870.8 6909.8 6966.8 6967.0 6994.3 6692.1 6765.0 6798.9 6806.4 6819.6 6719.2 6720.4 6721.2 6726.0 6737.3 4921.1 4993.6 4996.8 5002.4 5023.7 4456.4 4476.3 4523.7 4542.4 4555.0 6015.5 6077.2 6101.1 6152.3 6154.3 6709.6 6916.2 6949.1 6953.1 7016.3 5879.9 5941.8 6066.0 6110.3 6113.9 5875.3 5886.1 5947.4 5948.0 5966.9 6808.4 6819.0 6828.6 6837.1 6848.9 6711.8 6784.6 6850.6 6913.8 7059.5 6658.4 6670.0 6672.6 6675.8 6698.5 6522.9 6623.5 6686.9 6694.3 6711.9 6807.3 6816.9 6846.1 6853.4 6871.6 5704.7 6700.9 6701.8 6784.3 6788.3 6569.5 6702.3 6708.1 6803.9 6804.9 6442.5 6553.7 6608.9 6624.0 6702.7 6651.7 6660.4 6728.4 6747.2 6747.8 6355.3 6378.4 6381.8 6515.0 6568.1 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | [#1] ext.html Cycles:180 Average:37779.71 Median:36074.64 stddev:53710.03 (148.9%) stddev-sans-first:53788.85 03:16:30 INFO - PID 7712 | Values: 780.4 798.5 821.6 849.6 852.1 38709.8 39030.0 39225.8 39278.6 39391.0 35224.5 35499.6 35707.1 35871.0 36001.3 6737.6 6858.0 6907.6 6913.7 6920.0 6769.2 6785.2 7011.9 7690.3 7718.9 7644.8 7733.1 7758.3 7761.0 7771.1 7675.7 7711.3 7719.9 7720.2 7745.7 7653.6 7716.1 7725.9 7731.2 7744.5 36104.8 36491.1 36690.6 36713.4 36725.3 3552.7 3560.9 3591.8 3612.7 3616.7 30270.2 30570.8 30590.1 30650.7 30718.0 5015.2 5169.8 5195.4 5202.5 5296.3 180429.0 181459.0 187990.1 192044.0 199696.0 48099.3 48242.3 48416.3 48424.8 48571.0 49380.5 49429.3 49440.5 49493.8 49690.8 15390.3 15400.6 15435.8 15464.6 15486.8 12587.2 12649.4 12681.4 12737.3 12794.4 13722.6 14039.5 14040.9 14041.3 14144.3 5501.4 5662.2 5688.3 5719.5 5833.4 1008.3 1016.6 1022.9 1023.6 1029.1 22549.3 22559.2 22725.7 22760.2 22990.3 1085.5 1106.9 1111.0 1117.7 1124.2 12319.5 12384.7 12420.1 12448.5 12560.4 226320.0 229367.0 230032.0 230435.0 230650.0 50527.0 50536.5 50767.7 50972.0 50999.5 1414.5 1429.4 1432.1 1451.3 1452.4 22458.0 22539.4 22554.0 22685.0 22775.3 36044.5 36287.0 36336.3 36443.3 36545.5 201526.0 202645.0 202752.0 203069.0 203147.0 33378.7 35085.8 36674.4 36731.6 36797.8 44067.6 44982.3 45336.0 45368.0 45911.8 32958.0 33436.5 33510.0 33558.0 33804.3 33323.5 33654.0 34896.7 35423.6 35445.3 37435.4 38368.8 38498.0 39095.2 39327.8 39305.6 39388.0 39684.2 40134.8 40151.2 29264.6 29443.9 29640.7 30484.8 30491.5 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | [#2] jquery.html Cycles:180 Average:32870.29 Median:22603.71 stddev:73623.66 (325.7%) stddev-sans-first:73790.24 03:16:30 INFO - PID 7712 | Values: 563.3 564.9 566.4 572.4 576.5 21161.9 22189.7 22270.0 22329.2 22330.9 24024.6 25825.5 26088.5 26277.3 26374.9 6352.8 6520.8 6530.0 6534.5 6548.3 6382.0 6413.0 6421.2 6423.6 6427.7 5712.4 6276.4 6305.8 6316.8 6349.3 6263.8 6273.1 6276.5 6334.5 6347.1 5821.5 5856.1 5873.5 5888.6 5899.4 28375.4 28857.6 29061.6 29369.7 29457.9 2058.9 2101.0 2108.6 2123.1 2129.1 18452.8 19010.9 19095.9 19130.3 19231.6 2357.2 2366.4 2420.1 2424.0 2449.9 126423.0 128832.0 128952.0 129030.0 129245.0 13772.0 14031.8 14193.2 14681.2 14699.5 22472.1 22542.4 22615.2 22686.3 22833.7 9718.3 9923.6 9960.7 10032.6 10095.7 9156.0 9236.2 9294.7 9311.5 9426.4 8436.3 8760.3 8778.2 8832.9 8848.6 2645.4 2737.7 2766.8 2797.5 2905.6 933.4 956.0 956.7 983.7 985.5 20030.3 20567.3 20698.7 20758.0 20874.9 1027.9 1039.2 1044.8 1048.6 1058.8 11225.4 11261.7 11302.0 11330.4 11539.5 428272.0 429002.0 434909.0 437842.0 438477.0 112177.0 113653.0 113816.0 114447.0 117587.4 1173.5 1189.3 1189.9 1190.8 1204.1 18472.0 18525.2 18551.1 18740.4 19012.2 56460.7 57847.0 58017.4 58085.7 58567.4 71771.6 71896.3 72265.0 72347.3 73517.6 12140.6 14389.3 14626.0 14666.2 14744.0 18477.0 22592.2 23258.7 23519.2 24073.2 18406.7 18456.3 18494.1 18556.4 18612.4 16024.4 16554.8 16717.7 16780.0 16947.0 18462.3 18788.6 18910.8 19085.2 19320.7 14105.1 14152.7 14162.6 14247.7 14366.1 18141.3 18251.7 18342.7 18420.0 18707.0 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | [#3] mootools.html Cycles:180 Average:9300.91 Median:15002.14 stddev:6724.35 (44.8%) stddev-sans-first:6716.56 03:16:30 INFO - PID 7712 | Values: 1332.7 1398.0 1406.4 1415.5 1415.5 12724.2 14838.4 15378.8 15426.8 15429.8 12726.2 15286.8 15858.6 15874.4 15889.8 2699.8 2740.1 2746.4 2746.8 2751.4 2591.9 2725.9 2727.9 2732.4 2734.5 2586.2 2695.1 2765.7 2775.2 2781.3 2780.4 2812.4 2841.1 2855.4 2860.5 2768.2 2773.6 2793.6 2795.6 2808.8 14540.5 14867.9 14994.3 15019.2 15103.3 7939.3 8161.2 8176.9 8241.3 8283.2 5242.7 5323.5 5483.3 5523.4 5637.0 1888.5 1900.5 1913.5 1960.1 1963.6 25751.7 27237.9 27271.9 27357.7 27475.5 6775.5 6831.5 6924.9 6976.0 7160.4 16906.8 16943.6 16951.4 16957.4 16994.2 7772.1 7924.6 7960.0 7964.6 7966.8 7213.7 7297.5 7422.4 7565.6 7667.2 4995.0 5189.6 5201.3 5244.6 5297.4 1542.7 1549.5 1551.5 1563.7 1577.5 879.6 898.7 910.0 917.1 931.9 7553.6 7554.2 7571.0 7669.8 7698.2 718.5 731.0 962.8 1017.5 1020.9 5110.5 5164.4 5220.3 5231.5 5334.2 21483.1 22400.2 22402.7 22598.9 22606.4 21317.3 21722.7 21912.8 21974.1 22053.2 10659.8 10993.6 10997.9 11071.6 11092.9 7671.5 7795.6 7944.3 7994.9 8024.1 17676.6 18468.0 18483.4 18667.0 18705.3 18824.7 18877.7 18951.7 19102.1 19199.7 11144.9 11300.3 11327.5 11352.2 11356.1 14018.8 14094.7 14134.3 14228.8 14238.8 10664.8 10935.3 10963.2 11083.6 11100.0 11164.9 11207.1 11220.0 11321.9 11384.9 9699.0 9726.9 9741.9 9814.2 9900.2 6896.4 6906.7 7064.9 7079.9 7163.1 6770.5 6923.8 6973.0 6994.7 7056.8 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | [#4] prototype.html Cycles:180 Average:5511.71 Median:6195.10 stddev:1544.02 (24.9%) stddev-sans-first:1501.85 03:16:30 INFO - PID 7712 | Values: 500.6 501.7 521.6 530.3 530.5 6256.5 6341.4 6359.3 6362.2 6379.7 6155.7 6195.3 6255.3 6262.2 6277.2 5004.7 5007.6 5031.5 5039.3 5125.6 4877.3 5008.0 5037.2 5077.2 5102.3 4934.8 4981.2 4991.1 5056.0 5120.8 4955.8 4989.2 5019.4 5054.0 5079.8 4484.3 4504.0 4506.5 4512.1 4540.6 6055.7 6183.7 6194.9 6211.3 6214.3 5658.9 5787.8 5796.9 5805.1 5807.1 6609.2 6666.9 6667.7 6685.3 6707.4 4740.4 4852.3 4891.1 4924.9 4937.5 6843.0 6883.3 6982.5 7039.5 7100.7 4990.3 5007.6 5058.6 5059.6 5083.4 5034.2 5053.8 5116.8 5117.2 5176.7 5726.2 5747.3 5773.9 5778.9 5791.6 6679.4 6728.3 6734.6 6754.6 6806.2 1660.5 1669.2 1684.9 1698.4 1759.8 1191.3 1220.8 1221.7 1222.4 1240.7 5667.5 5794.5 5831.6 5852.4 5919.4 6609.5 6643.5 6677.4 6686.8 6713.9 5701.7 5769.2 5821.9 5825.8 5891.9 3508.4 3544.0 3547.3 3562.2 3568.2 6406.2 6480.6 6500.3 6505.9 6592.6 6767.7 6774.2 6789.8 6791.7 6797.1 6415.2 6473.3 6499.5 6510.5 6530.3 6545.3 6584.4 6631.4 6636.2 6669.7 6448.9 6498.7 6522.7 6525.6 6537.0 6383.3 6393.6 6411.9 6415.8 6452.6 4834.5 4866.3 4869.6 4876.7 4888.6 6469.9 6547.3 6625.8 6648.6 6698.7 6236.3 6262.6 6321.6 6335.3 6392.6 6021.6 6293.3 6425.9 6563.1 6574.2 6421.4 6491.0 6542.7 6588.1 6595.3 6587.2 6609.2 6614.4 6616.2 6635.6 6141.3 6293.7 6337.3 6339.1 6407.2 03:16:30 INFO - PID 7712 | 03:16:30 INFO - PID 7712 | [#5] yui.html Cycles:180 Average:23334.10 Median:19516.71 stddev:31651.17 (162.2%) stddev-sans-first:31695.13 03:16:30 INFO - PID 7712 | Values: 898.5 899.7 911.5 915.7 915.9 17227.0 17502.8 17520.8 17640.1 17680.7 19622.9 20217.4 20251.2 20314.1 20422.0 988.1 1000.3 1000.5 1002.5 1008.3 906.7 992.2 997.8 1013.3 1014.3 1035.1 1051.1 1052.1 1053.1 1053.5 1045.4 1048.2 1051.3 1051.6 1051.9 772.4 772.6 773.0 773.2 774.8 19332.5 19431.3 19464.6 19520.4 20860.5 21012.4 21154.7 21355.8 21615.2 21682.7 16307.6 16775.2 16814.3 16876.5 16896.3 3654.8 3690.4 3694.1 3736.4 3747.0 126019.4 126470.4 126760.0 128289.0 129409.0 15479.8 15574.1 15933.7 15937.9 16316.6 28998.9 30135.5 30191.0 30416.0 30655.7 8608.9 8672.7 8715.6 8745.5 8791.6 4140.5 4208.7 4227.3 4233.0 4247.8 5798.9 6075.2 6127.6 6140.0 6156.8 1162.2 1192.8 1212.0 1212.9 1214.5 675.0 679.5 702.1 702.3 708.9 11631.8 12220.6 12244.8 12698.1 12960.2 663.9 691.8 701.5 718.6 722.3 5445.2 5661.0 5748.4 5779.3 5816.0 105980.1 106557.5 107399.4 107610.0 108832.0 97578.5 97957.0 98863.5 100196.5 104503.0 83876.2 84413.2 85270.0 85372.0 88665.6 10534.3 10630.0 10647.8 10764.4 10835.2 39545.4 39862.4 40718.4 40972.4 41121.0 51467.0 51890.7 53803.2 53979.7 68965.7 15850.9 16488.4 16504.0 16735.8 18637.8 17759.6 18830.0 19238.6 19789.0 21336.0 19376.6 19483.6 19513.0 19795.9 19976.7 18427.4 19071.7 19132.6 19375.7 19441.6 18079.1 18380.7 18881.6 19300.2 19539.1 13433.6 13916.1 14317.0 14432.9 14507.9 14060.9 14173.9 14228.1 14246.9 15573.0 03:16:30 INFO - PID 7712 | -------- Summary: end -------- 03:16:30 INFO - PID 7712 | 03:16:31 INFO - TEST-INFO | 7712: exit 0 03:16:31 INFO - TEST-OK | dromaeo_css | took 1114956ms 03:16:31 INFO - TEST-START | kraken 03:16:31 INFO - Initialising browser for kraken test... 03:16:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34575/getInfo.html -profile /tmp/tmp7M7bfM/profile 03:16:31 INFO - TEST-INFO | started process 8101 (/builds/slave/test/build/application/firefox/firefox http://localhost:34575/getInfo.html) 03:16:38 INFO - TEST-INFO | 8101: exit 0 03:16:38 INFO - Browser initialized. 03:16:38 INFO - Running cycle 1/1 for kraken test... 03:16:38 INFO - Using env: {'DISPLAY': ':0', 03:16:38 INFO - 'HOME': '/home/cltbld', 03:16:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:16:38 INFO - 'LANG': 'en_US.UTF-8', 03:16:38 INFO - 'LANGUAGE': 'en_US:en', 03:16:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:16:38 INFO - 'LOGNAME': 'cltbld', 03:16:38 INFO - 'MAIL': '/var/mail/cltbld', 03:16:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:38 INFO - 'MOZ_ACCELERATED': '1', 03:16:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:16:38 INFO - 'MOZ_NO_REMOTE': '1', 03:16:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:38 INFO - 'MOZ_WEBRENDER': '1', 03:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:38 INFO - 'NO_EM_RESTART': '1', 03:16:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:38 INFO - 'PWD': '/builds/slave/test', 03:16:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:38 INFO - 'RUST_BACKTRACE': 'full', 03:16:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:16:38 INFO - 'SHELL': '/bin/bash', 03:16:38 INFO - 'SHLVL': '1', 03:16:38 INFO - 'TERM': 'linux', 03:16:38 INFO - 'TMOUT': '86400', 03:16:38 INFO - 'USER': 'cltbld', 03:16:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759', 03:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:38 INFO - '_': '/tools/buildbot/bin/python'} 03:16:38 INFO - TEST-INFO | started process 8296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7M7bfM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:39 INFO - PID 8296 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:16:39 INFO - PID 8296 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:16:39 INFO - PID 8296 | 03:16:39 INFO - PID 8296 | (/builds/slave/test/build/application/firefox/firefox:8358): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:16:39 INFO - PID 8296 | 03:16:50 INFO - PID 8296 | RSS: Main: 207720448 03:16:50 INFO - PID 8296 | 03:16:52 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34575/tests/kraken/driver.html?testName=audio-beat-detection) 03:16:53 INFO - PID 8296 | RSS: Main: 213737472 03:16:53 INFO - PID 8296 | 03:16:56 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34575/tests/kraken/driver.html?testName=audio-dft) 03:16:57 INFO - PID 8296 | RSS: Main: 213463040 03:16:57 INFO - PID 8296 | 03:17:00 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34575/tests/kraken/driver.html?testName=audio-fft) 03:17:00 INFO - PID 8296 | RSS: Main: 207683584 03:17:00 INFO - PID 8296 | 03:17:02 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34575/tests/kraken/driver.html?testName=audio-oscillator) 03:17:03 INFO - PID 8296 | RSS: Main: 208244736 03:17:03 INFO - PID 8296 | 03:17:05 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:06 INFO - PID 8296 | RSS: Main: 208785408 03:17:06 INFO - PID 8296 | 03:17:09 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34575/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:10 INFO - PID 8296 | RSS: Main: 211435520 03:17:10 INFO - PID 8296 | 03:17:13 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34575/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:14 INFO - PID 8296 | RSS: Main: 212320256 03:17:14 INFO - PID 8296 | 03:17:17 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34575/tests/kraken/driver.html?testName=json-parse-financial) 03:17:17 INFO - PID 8296 | RSS: Main: 211177472 03:17:17 INFO - PID 8296 | 03:17:19 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:20 INFO - PID 8296 | RSS: Main: 211714048 03:17:20 INFO - PID 8296 | 03:17:21 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:22 INFO - PID 8296 | RSS: Main: 210063360 03:17:22 INFO - PID 8296 | 03:17:24 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:25 INFO - PID 8296 | RSS: Main: 208756736 03:17:25 INFO - PID 8296 | 03:17:27 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:28 INFO - PID 8296 | RSS: Main: 210046976 03:17:28 INFO - PID 8296 | 03:17:31 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:32 INFO - PID 8296 | RSS: Main: 209657856 03:17:32 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | Cycle 1(1): loaded http://localhost:34575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34575/tests/kraken/driver.html?testName=ai-astar) 03:17:34 INFO - PID 8296 | RSS: Main: 212115456 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | __start_tp_report 03:17:34 INFO - PID 8296 | _x_x_mozilla_page_load 03:17:34 INFO - PID 8296 | _x_x_mozilla_page_load_details 03:17:34 INFO - PID 8296 | |i|pagename|runs| 03:17:34 INFO - PID 8296 | |0;ai-astar;102;114;107;107;111;116;113;101;117;116 03:17:34 INFO - PID 8296 | |1;audio-beat-detection;170;126;143;175;118;154;154;119;185;118 03:17:34 INFO - PID 8296 | |2;audio-dft;165;164;163;167;163;169;168;166;165;164 03:17:34 INFO - PID 8296 | |3;audio-fft;82;74;79;177;75;74;75;83;180;74 03:17:34 INFO - PID 8296 | |4;audio-oscillator;80;79;137;80;79;89;144;82;83;137 03:17:34 INFO - PID 8296 | |5;imaging-gaussian-blur;122;115;114;120;115;120;116;126;115;118 03:17:34 INFO - PID 8296 | |6;imaging-darkroom;156;155;149;157;149;148;151;150;158;147 03:17:34 INFO - PID 8296 | |7;imaging-desaturate;95;102;96;98;98;106;97;94;100;97 03:17:34 INFO - PID 8296 | |8;json-parse-financial;53;53;52;54;52;52;62;59;59;54 03:17:34 INFO - PID 8296 | |9;json-stringify-tinderbox;53;48;38;39;39;40;41;40;44;39 03:17:34 INFO - PID 8296 | |10;stanford-crypto-aes;78;80;74;79;82;76;75;78;79;78 03:17:34 INFO - PID 8296 | |11;stanford-crypto-ccm;133;122;127;131;139;121;125;116;118;167 03:17:34 INFO - PID 8296 | |12;stanford-crypto-pbkdf2;178;169;180;174;179;183;170;172;167;170 03:17:34 INFO - PID 8296 | |13;stanford-crypto-sha256-iterative;65;64;65;65;65;71;63;64;65;63 03:17:34 INFO - PID 8296 | __end_tp_report 03:17:34 INFO - PID 8296 | __start_cc_report 03:17:34 INFO - PID 8296 | _x_x_mozilla_cycle_collect,930 03:17:34 INFO - PID 8296 | __end_cc_report 03:17:34 INFO - PID 8296 | __startTimestamp1504347454363__endTimestamp 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | ------- Summary: start ------- 03:17:34 INFO - PID 8296 | Number of tests: 14 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#0] ai-astar Cycles:10 Average:110.40 Median:113.50 stddev:5.85 (5.2%) stddev-sans-first:5.36 03:17:34 INFO - PID 8296 | Values: 102.0 114.0 107.0 107.0 111.0 116.0 113.0 101.0 117.0 116.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:154.00 stddev:25.32 (16.4%) stddev-sans-first:25.35 03:17:34 INFO - PID 8296 | Values: 170.0 126.0 143.0 175.0 118.0 154.0 154.0 119.0 185.0 118.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:2.07 (1.2%) stddev-sans-first:2.19 03:17:34 INFO - PID 8296 | Values: 165.0 164.0 163.0 167.0 163.0 169.0 168.0 166.0 165.0 164.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#3] audio-fft Cycles:10 Average:97.30 Median:75.00 stddev:42.93 (57.2%) stddev-sans-first:45.18 03:17:34 INFO - PID 8296 | Values: 82.0 74.0 79.0 177.0 75.0 74.0 75.0 83.0 180.0 74.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#4] audio-oscillator Cycles:10 Average:99.00 Median:80.00 stddev:28.05 (35.1%) stddev-sans-first:28.89 03:17:34 INFO - PID 8296 | Values: 80.0 79.0 137.0 80.0 79.0 89.0 144.0 82.0 83.0 137.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:119.00 stddev:3.87 (3.3%) stddev-sans-first:3.84 03:17:34 INFO - PID 8296 | Values: 122.0 115.0 114.0 120.0 115.0 120.0 116.0 126.0 115.0 118.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:153.00 stddev:4.08 (2.7%) stddev-sans-first:4.07 03:17:34 INFO - PID 8296 | Values: 156.0 155.0 149.0 157.0 149.0 148.0 151.0 150.0 158.0 147.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:96.50 stddev:3.56 (3.7%) stddev-sans-first:3.57 03:17:34 INFO - PID 8296 | Values: 95.0 102.0 96.0 98.0 98.0 106.0 97.0 94.0 100.0 97.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.62 (6.7%) stddev-sans-first:3.77 03:17:34 INFO - PID 8296 | Values: 53.0 53.0 52.0 54.0 52.0 52.0 62.0 59.0 59.0 54.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#9] json-stringify-tinderbox Cycles:10 Average:42.10 Median:40.50 stddev:4.86 (12.0%) stddev-sans-first:3.18 03:17:34 INFO - PID 8296 | Values: 53.0 48.0 38.0 39.0 39.0 40.0 41.0 40.0 44.0 39.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:2.38 (3.0%) stddev-sans-first:2.52 03:17:34 INFO - PID 8296 | Values: 78.0 80.0 74.0 79.0 82.0 76.0 75.0 78.0 79.0 78.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:129.00 stddev:14.83 (11.5%) stddev-sans-first:15.69 03:17:34 INFO - PID 8296 | Values: 133.0 122.0 127.0 131.0 139.0 121.0 125.0 116.0 118.0 167.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:176.00 stddev:5.45 (3.1%) stddev-sans-first:5.61 03:17:34 INFO - PID 8296 | Values: 178.0 169.0 180.0 174.0 179.0 183.0 170.0 172.0 167.0 170.0 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.26 (3.5%) stddev-sans-first:2.40 03:17:34 INFO - PID 8296 | Values: 65.0 64.0 65.0 65.0 65.0 71.0 63.0 64.0 65.0 63.0 03:17:34 INFO - PID 8296 | -------- Summary: end -------- 03:17:34 INFO - PID 8296 | 03:17:34 INFO - PID 8296 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:17:35 INFO - TEST-INFO | 8296: exit 0 03:17:35 INFO - TEST-OK | kraken | took 63578ms 03:17:35 INFO - SUITE-END | took 1178s 03:17:35 INFO - Completed test suite (00:19:38) 03:17:35 INFO - javascript benchmark 03:17:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8544.123464494895, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.688619581139, 3337.3992681317354, 3339.6326404095544, 3351.245969656827, 3383.5093911382833, 6207.0, 6331.620102793836, 6390.8402289942715, 6404.775832845851, 6429.164208652875, 6463.4829213662915, 6498.642574658392, 6544.640044797547, 6552.672366381674, 6576.243731970825, 5834.912476312858, 5872.765089396419, 5908.350081491043, 5952.851178720523, 5981.312149102865, 5688.232088668039, 5688.516476099537, 5791.652500849962, 5827.941720582803, 5875.383084776101, 5814.738336774813, 5826.242588463515, 5903.586748927577, 5910.34986151523, 5913.408659134096, 5755.913661295084, 5846.415358464162, 5857.474417656939, 5871.677057761822, 5913.586048976574, 5587.972060139714, 5686.3744988051285, 5706.457886500776, 5773.364929857712, 5868.03177475716, 6225.688715564203, 6228.37716228378, 6330.208723909512, 6457.773977910751, 6459.709313080875, 6700.229473610549, 6861.965690171517, 6876.140482439695, 6893.4140598049225, 6943.305669433067, 6814.62519561424, 6897.9655101724675, 6901.206361268418, 6913.1358580177475, 6952.443804495679, 6263.906041409383, 6311.463525600376, 6343.746250150035, 6427.87144257117, 6520.510961677845, 7107.289271072851, 7116.644167791694, 7121.430285577245, 7126.750563730245, 7211.350978411968, 6724.193096828412, 6727.596344219362, 6735.595864248161, 6777.322267773183, 6837.9658101710165, 6870.7595234166565, 6909.7581584644295, 6966.790996270019, 6967.0, 6994.265602111806, 6692.096566963398, 6764.966175169191, 6798.8640227196165, 6806.421454176351, 6819.5908245505425, 6719.227288861745, 6720.361565651256, 6721.1598550181225, 6726.0, 6737.292584278678, 4921.114199444134, 4993.625478089158, 4996.775145118479, 5002.424721157041, 5023.673461225008, 4456.3538286948215, 4476.261416866246, 4523.683342166082, 4542.409486766765, 4555.020670555847, 6015.488683461867, 6077.17958075663, 6101.115338275925, 6152.261728592597, 6154.292256390483, 6709.630970296583, 6916.20463646687, 6949.061876646689, 6953.061336719579, 7016.2632923543315, 5879.911801322984, 5941.792037278675, 6065.999110146865, 6110.327863934964, 6113.877722445526, 5875.324337701134, 5886.087656413263, 5947.405259474018, 5947.9702601486715, 5966.880662386728, 6808.38724514796, 6819.0, 6828.624425656537, 6837.1111755471475, 6848.897266541006, 6711.765088221889, 6784.559003664746, 6850.588964662136, 6913.75801846933, 7059.541129826544, 6658.43403310724, 6669.966650166718, 6672.633005184762, 6675.799726008033, 6698.497612678971, 6522.902156467751, 6623.536352455282, 6686.899696504459, 6694.29709880475, 6711.899321510279, 6807.319268073153, 6816.897746533905, 6846.075779769667, 6853.417459515797, 6871.622060786704, 5704.714764261853, 6700.899486507804, 6701.832454188684, 6784.321567843176, 6788.253292137762, 6569.507286953593, 6702.262751097278, 6708.127943367331, 6803.863922721419, 6804.863902721819, 6442.452391546583, 6553.672316384257, 6608.933910660832, 6623.966880165568, 6702.698378572878, 6651.667416629246, 6660.433863121689, 6728.428083612947, 6747.190337159573, 6747.797566073025, 6355.269144048493, 6378.394052564999, 6381.840453988688, 6514.967425162844, 6568.113304703804], "value": 6227.189264482769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.4146889832625, 798.504926945294, 821.5892053973014, 849.6346570974487, 852.0627309959045, 38709.80645096774, 39030.0, 39225.80387098068, 39278.607213927855, 39391.0, 35224.471632925524, 35499.64500354996, 35707.10732231695, 35871.0, 36001.27997440056, 6737.595744255336, 6858.0, 6907.620080895549, 6913.723451061952, 6920.0, 6769.18769747631, 6785.21969973452, 7011.859762804741, 7690.3078722914925, 7718.884216736754, 7644.847103057936, 7733.149353571102, 7758.262965018343, 7760.961195194016, 7771.067471903351, 7675.692972281102, 7711.3059824615775, 7719.884201736979, 7720.189380115091, 7745.651445684957, 7653.579053152074, 7716.074071111502, 7725.884111738328, 7731.188225236382, 7744.49660772048, 36104.81947590272, 36491.08772280688, 36690.633093669254, 36713.449298260544, 36725.265494690226, 3552.662497062775, 3560.893173204808, 3591.7665351752053, 3612.674859262679, 3616.65641764032, 30270.24324391886, 30570.847145764128, 30590.08229753111, 30650.693493065006, 30718.0, 5015.247712843103, 5169.844904652867, 5195.350581177353, 5202.531772140488, 5296.285001524783, 180429.0, 181459.0, 187990.12009879862, 192044.0, 199696.00151999292, 48099.27851082237, 48242.31151909736, 48416.27375589369, 48424.757876210395, 48571.02857942821, 49380.50619493831, 49429.25856112161, 49440.50559494359, 49493.77278022498, 49690.75154624276, 15390.3074361654, 15400.61498462525, 15435.768463473058, 15464.60818526338, 15486.767698484531, 12587.244765313928, 12649.367531623382, 12681.429335679917, 12737.29944853042, 12794.424250908545, 13722.588322350346, 14039.50861719835, 14040.929795350958, 14041.297935103408, 14144.292785360896, 5501.394846566875, 5662.17898404729, 5688.260526131577, 5719.512012274674, 5833.38749431312, 1008.3193844155165, 1016.5628779624832, 1022.9079382855579, 1023.5956797065118, 1029.0789743179812, 22549.323520294416, 22559.210427634953, 22725.659115113285, 22760.20339288117, 22990.310290691305, 1085.5115198160859, 1106.9428695595686, 1111.0112000319723, 1117.6702872652586, 1124.150279042623, 12319.507219711291, 12384.690382740324, 12420.130590858553, 12448.502059917682, 12560.434780434902, 226320.0, 229367.0, 230032.0, 230435.0, 230650.0, 50526.98946021059, 50536.49463505392, 50767.74616126969, 50972.0, 50999.49000510022, 1414.4625042483997, 1429.428228708525, 1432.1264028942337, 1451.3468938977715, 1452.3899962015978, 22458.0, 22539.436514086625, 22554.0, 22685.0, 22775.316740497812, 36044.45933311055, 36287.0, 36336.27327453489, 36443.27113457769, 36545.45181822328, 201526.0, 202645.0, 202752.0, 203069.0, 203147.0, 33378.66621333756, 35085.82457087698, 36674.44988325231, 36731.63268367282, 36797.81601091977, 44067.55932440634, 44982.325265121704, 45336.0, 45368.0, 45911.77044114758, 32958.0, 33436.498452523716, 33510.0, 33558.0, 33804.3239135211, 33323.50014749829, 33654.0, 34896.65103349036, 35423.64576354204, 35445.29109417849, 37435.43846842354, 38368.80815595904, 38498.0, 39095.218095637356, 39327.80336098301, 39305.606943931336, 39388.0, 39684.2063158741, 40134.79932600318, 40151.1969760609, 29264.56103158412, 29443.85278073596, 29640.703592963793, 30484.847575761978, 30491.542626861057], "value": 17178.508019781635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2733773432273, 564.8700798816272, 566.4363957861925, 572.3875453265006, 576.4955663794182, 21161.894190529045, 22189.667154992687, 22269.997850096763, 22329.218477353297, 22330.88834555827, 24024.639630405556, 25825.48349033023, 26088.47823043538, 26277.34306642335, 26374.86812565939, 6352.84117897054, 6520.836979075538, 6530.0, 6534.477241820643, 6548.345165483437, 6382.042693595951, 6412.967935160341, 6421.165248517686, 6423.614583125028, 6427.678616069201, 5712.400197979194, 6276.372362763733, 6305.842353941165, 6316.778912738055, 6349.333320001402, 6263.812085637438, 6273.090401891723, 6276.466500347453, 6334.524910631675, 6347.111404403341, 5821.53427725781, 5856.121581762727, 5873.471387575139, 5888.617239879437, 5899.439553242435, 28375.432491350264, 28857.56713649297, 29061.564076538867, 29369.706302937124, 29457.852710736308, 2058.9485262868398, 2100.978990210109, 2108.630989576818, 2123.055240418015, 2129.0525716056363, 18452.815471845242, 19010.904945475322, 19095.90452047731, 19130.33043843473, 19231.615367692706, 2357.233898982837, 2366.408397900525, 2420.068273714615, 2423.987880060606, 2449.8775061246865, 126423.0, 128832.0, 128952.0, 129030.0, 129245.0, 13772.0, 14031.78952315716, 14193.219372934382, 14681.19253441071, 14699.485518007032, 22472.101115955506, 22542.436439089153, 22615.208467703553, 22686.319410417713, 22833.657495137588, 9718.271129665303, 9923.603055877684, 9960.701178964642, 10032.64885728996, 10095.7476063099, 9155.992840787641, 9236.214921731727, 9294.676330917271, 9311.463608504657, 9426.387284826464, 8436.325093992466, 8760.342974276828, 8778.166074222938, 8832.8675069874, 8848.646054157762, 2645.4444566641223, 2737.7262273772462, 2766.806323557332, 2797.4964506389047, 2905.5932169496286, 933.3653115881266, 955.9713208603753, 956.7464621875208, 983.7245571240064, 985.5072463768116, 20030.298939537046, 20567.280145195145, 20698.68951965722, 20757.962101894846, 20874.895625521774, 1027.8869324374314, 1039.1790485516508, 1044.8484969679505, 1048.5700862646431, 1058.767071244325, 11225.382603956861, 11261.66215013551, 11302.0, 11330.37682927447, 11539.538418463168, 428272.0, 429002.0, 434909.0, 437842.0, 438477.0, 112177.0, 113653.0, 113816.0, 114447.0, 117587.41206293914, 1173.5481839491856, 1189.3102000839492, 1189.8512685914088, 1190.827330037157, 1204.1450570095155, 18472.0, 18525.166367513764, 18551.07244637736, 18740.437786866416, 19012.239510419982, 56460.71769641126, 57847.0, 58017.419825801204, 58085.70957145356, 58567.414325856196, 71771.64114179605, 71896.28103718896, 72265.0, 72347.27652723405, 73517.63241183759, 12140.635780926586, 14389.280535973368, 14626.0, 14666.193359365338, 14744.0, 18477.0, 22592.209272675376, 23258.651120232873, 23519.176828811593, 24073.157439489532, 18406.723899141256, 18456.26174952987, 18494.0752962354, 18556.350527731465, 18612.44162675122, 16024.359025638843, 16554.751678724588, 16717.74923376126, 16780.0, 16947.0, 18462.261509540007, 18788.624227515647, 18910.810891890906, 19085.236590536224, 19320.71018934689, 14105.083169593943, 14152.716945661236, 14162.575122746333, 14247.71504569882, 14366.13803171813, 18141.27434902589, 18251.726224106384, 18342.724859126858, 18420.0, 18707.0], "value": 11821.536450722386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.7401156774429, 1397.9510717124904, 1406.430395689746, 1415.4621243927306, 1415.5187236339646, 12724.172928759624, 14838.40646374145, 15378.846211537895, 15426.768598471032, 15429.845701542981, 12726.172798768097, 15286.84713152868, 15858.603534911634, 15874.365025399, 15889.841101588981, 2699.7705195058443, 2740.0957683964343, 2746.436980419019, 2746.8489233092273, 2751.3671855473153, 2591.883365248559, 2725.945481090377, 2727.9181624551197, 2732.4261904999976, 2734.507788598052, 2586.237060067285, 2695.0567301444535, 2765.7096004919495, 2775.2090654163567, 2781.2629653141935, 2780.3605170810724, 2812.395335002984, 2841.076650088709, 2855.4003659231585, 2860.4994126027964, 2768.1557125076843, 2773.611694362791, 2793.6368272124696, 2795.55271156616, 2808.7893407994484, 14540.491082812157, 14867.851321486754, 14994.325255363536, 15019.173945432996, 15103.32035058414, 7939.28546430824, 8161.183881611851, 8176.877346839802, 8241.269333439985, 8283.17168283173, 5242.659227150261, 5323.494268044529, 5483.287172667528, 5523.392426833045, 5636.971815140939, 1888.5184278009158, 1900.5438694713307, 1913.5311848597044, 1960.0689672405636, 1963.577830766392, 25751.742482575122, 27237.863810681018, 27271.86364068187, 27357.726422735715, 27475.450490990068, 6775.525713200127, 6831.521793474509, 6924.93075069253, 6975.965120174468, 7160.391366733782, 16906.830931690773, 16943.576410589587, 16951.40670076566, 16957.40649077301, 16994.235259413355, 7772.106207786177, 7924.603769811486, 7959.9602001989615, 7964.601769911481, 7966.84066318682, 7213.71145154188, 7297.525660832029, 7422.369098626677, 7565.583892885944, 7667.233276672288, 4995.0, 5189.636725429259, 5201.349831271091, 5244.5542128918705, 5297.443768404339, 1542.706885691715, 1549.4654344251214, 1551.4724993502264, 1563.6794457136486, 1577.4873166221023, 879.6261588824724, 898.7438580004667, 909.9545022748836, 917.1058218237165, 931.8835145606799, 7553.584552849646, 7554.169041405441, 7571.0, 7669.808254793675, 7698.230176982257, 718.547315191426, 730.9693332401289, 962.8411312133419, 1017.531935309751, 1020.9336393134422, 5110.4634013428795, 5164.406093299319, 5220.321358223483, 5231.476852314738, 5334.226537152092, 21483.14067437285, 22400.215992440186, 22402.663960040612, 22598.887005564866, 22606.434839129153, 21317.25389611356, 21722.674159887614, 21912.780872191073, 21974.121035158736, 22053.22813701513, 10659.84010239847, 10993.61522346714, 10997.890021099847, 11071.612493562849, 11092.944535277433, 7671.462997590115, 7795.649195786316, 7944.285014348737, 7994.880076798736, 8024.0772311184965, 17676.558086047953, 18468.0, 18483.445496635122, 18667.0, 18705.25178992825, 18824.717629235845, 18877.71683424777, 18951.715724264424, 19102.140403682144, 19199.712004320227, 11144.944275278573, 11300.321980680857, 11327.546898124312, 11352.205345625727, 11356.148288878532, 14018.789718154032, 14094.718105637625, 14134.293285335487, 14228.786568201278, 14238.786418203943, 10664.84002739975, 10935.343879367263, 10963.177761668067, 11083.612073577386, 11100.0, 11164.944175279397, 11207.10343172528, 11220.0, 11321.924417180355, 11384.886151138382, 9699.0, 9726.902730972883, 9741.902580974383, 9814.214862810815, 9900.158486528726, 6896.413804826646, 6906.723731050903, 7064.894026589503, 7079.910977155527, 7163.06880105583, 6770.526063175727, 6923.792286231421, 6972.988916607165, 6994.720211191496, 7056.82357941035], "value": 6651.120786312861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.62703286051897, 501.7081016382815, 521.642674767784, 530.2682298428168, 530.4617405713661, 6256.499480041597, 6341.365863413656, 6359.282993591727, 6362.204724409449, 6379.744810207592, 6155.692215389235, 6195.2565692117005, 6255.2806427260875, 6262.185915830947, 6277.152584401116, 5004.724740139291, 5007.649464537484, 5031.52200540948, 5039.269305950654, 5125.589952803785, 4877.34155888954, 5007.974960125212, 5037.204351584869, 5077.162268225738, 5102.336696229485, 4934.830068592034, 4981.203007518798, 4991.126552853254, 5055.9747201263945, 5120.795168193268, 4955.752212389366, 4989.226669866177, 5019.372578427697, 5054.028928717767, 5079.7714102865275, 4484.260097083978, 4503.954960450386, 4506.459224893001, 4512.12013657337, 4540.591346778772, 6055.727492262815, 6183.690815459254, 6194.938050619527, 6211.260846962858, 6214.254289485246, 5658.858528536778, 5787.797427090074, 5796.8840623187725, 5805.129230615399, 5807.128930660392, 6609.239937407212, 6666.866632672409, 6667.666616669196, 6685.331466853324, 6707.411534828843, 4740.360051393087, 4852.272159176152, 4891.095147397743, 4924.876878078041, 4937.530934561211, 6843.0, 6883.27725588816, 6982.47631427645, 7039.507234493588, 7100.680469378839, 4990.251462280615, 5007.624428167902, 5058.595312375001, 5059.645824792229, 5083.38999320084, 5034.194528875362, 5053.797848086036, 5116.846494605168, 5117.206832940826, 5176.7152806596, 5726.198332233491, 5747.3103227612955, 5773.855653608609, 5778.88442231153, 5791.623544469596, 6679.365460281266, 6728.2809611830535, 6734.56225345351, 6754.5609535380045, 6806.217285012287, 1660.5433505786004, 1669.2071266148725, 1684.89890606564, 1698.3970690404728, 1759.8416142547233, 1191.2852288626755, 1220.8473940757406, 1221.7251118498446, 1222.4010234984794, 1240.683625675447, 5667.4615911488345, 5794.536437085023, 5831.620944638585, 5852.385499522574, 5919.378465261172, 6609.537332386687, 6643.5017373697165, 6677.3656502632175, 6686.759935421591, 6713.932860671429, 5701.686407247558, 5769.1923130761725, 5821.912671309934, 5825.825225243249, 5891.882162356729, 3508.3509550733197, 3544.0, 3547.2728090741334, 3562.2163124112653, 3568.197155640012, 6406.199225096863, 6480.57876238043, 6500.317466666026, 6505.902411463831, 6592.604443733391, 6767.729290828312, 6774.187097548227, 6789.830254243683, 6791.72833086671, 6797.0628370914055, 6415.235810152152, 6473.287938326875, 6499.512536559777, 6510.511711621647, 6530.346965303622, 6545.345465453607, 6584.374484423972, 6631.403173714196, 6636.2368327642935, 6669.666516674244, 6448.871022579616, 6498.707558159988, 6522.739090436519, 6525.608463492205, 6537.019447082976, 6383.297837237993, 6393.6163830170335, 6411.903821442776, 6415.807525774234, 6452.612843229421, 4834.492378300228, 4866.318715379779, 4869.586085182799, 4876.658633895593, 4888.560029597354, 6469.867773139776, 6547.345265473415, 6625.768098116543, 6648.634325112165, 6698.7320507179165, 6236.251649802053, 6262.592931459622, 6321.589096708699, 6335.271443784024, 6392.648404337806, 6021.638701677914, 6293.307736149111, 6425.915560531064, 6563.146790917151, 6574.243961944247, 6421.389967953037, 6490.967545162244, 6542.738290468328, 6588.110605068255, 6595.274519802914, 6587.176602924635, 6609.173853268341, 6614.404703576702, 6616.172978377703, 6635.601863888182, 6141.324454309933, 6293.748250069946, 6337.334579869232, 6339.1125242467015, 6407.231132264158], "value": 5055.2313285478895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.4743924803988, 899.7300809757076, 911.4804561400005, 915.6612053540191, 915.8580420034897, 17227.0, 17502.82497175028, 17520.82479175208, 17640.117994100307, 17680.73478897816, 19622.901885490588, 20217.393478195678, 20251.189952401925, 20314.08586613602, 20422.0, 988.1403179234077, 1000.3397757480064, 1000.4597517340627, 1002.4536627537973, 1008.2790804574728, 906.6735975048977, 992.1814503034989, 997.7755005123862, 1013.3058854684565, 1014.2646581228624, 1035.1201478743083, 1051.148569658579, 1052.1267348101057, 1053.0785562632695, 1053.536443964653, 1045.4354648489807, 1048.2138396202847, 1051.2903789941759, 1051.621416290135, 1051.9421431821247, 772.3898120484811, 772.5905270206799, 772.9536227826292, 773.1649818196335, 774.8024253815297, 19332.516687082796, 19431.319903803298, 19464.610707785763, 19520.414387568395, 20860.47848803777, 21012.369628911158, 21154.682679759815, 21355.78644213569, 21615.243466478754, 21682.674759878613, 16307.592310192222, 16775.2451139699, 16814.32742690291, 16876.493705188863, 16896.324147034225, 3654.8172591370326, 3690.3541880171133, 3694.11341278094, 3736.3648179809225, 3747.0445036515785, 126019.3699031499, 126470.36764816118, 126760.0, 128289.0, 129409.0, 15479.767803482957, 15574.143422111665, 15933.681326373408, 15937.920310398606, 16316.592085197728, 28998.855005725258, 30135.547966780516, 30191.0, 30416.0, 30655.69344306573, 8608.913910860936, 8672.739817805475, 8715.564221788885, 8745.475271483605, 8791.648334066693, 4140.4617399738445, 4208.6633069354375, 4227.260229459832, 4232.978835105805, 4247.787610619456, 5798.88402231953, 6075.179850720185, 6127.571070025056, 6140.0, 6156.846078848064, 1162.2096974057554, 1192.8389667394965, 1211.9697007574705, 1212.927224366541, 1214.5263347294563, 674.9763758268437, 679.4835924697265, 702.0942983551162, 702.2661318921739, 708.8582283543209, 11631.825522617168, 12220.594631617478, 12244.81632775509, 12698.11113222084, 12960.157589756636, 663.9269680335159, 691.8097523181065, 701.5229643842237, 718.5939943931662, 722.3354513847273, 5445.210444485528, 5661.0, 5748.367679555246, 5779.306483221956, 5816.0, 105980.1459155596, 106557.46721266344, 107399.38900916492, 107610.0, 108832.0, 97578.512107439, 97957.0, 98863.50568247112, 100196.49901750445, 104503.0, 83876.16123838683, 84413.15586844175, 85270.0, 85372.0, 88665.55667221623, 10534.262601617813, 10630.043296103388, 10647.840282395926, 10764.3541387517, 10835.187360948117, 39545.406818898315, 39862.40206396848, 40718.38922416107, 40972.3854142194, 41121.0, 51467.0, 51890.74054629703, 53803.19295210653, 53979.73010134924, 68965.65517172382, 15850.920745396199, 16488.422905198262, 16504.00975941447, 16735.832641673915, 18637.81362186415, 17759.644807104043, 18830.0, 19238.61522769509, 19789.0, 21336.0, 19376.61246775085, 19483.61032779308, 19513.0, 19795.901020494806, 19976.70034949506, 18427.447176584723, 19071.713924291424, 19132.617347653246, 19375.709364359827, 19441.61116777685, 18079.096045197424, 18380.724289135407, 18881.622367552296, 19300.22799088021, 19539.120739566468, 13433.596992090253, 13916.095453795471, 14317.0, 14432.927835360755, 14507.854921450651, 14060.859391406364, 14173.929130354281, 14228.146311220946, 14246.928765356108, 15573.0], "value": 9149.394217652449, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 107.0, 107.0, 111.0, 116.0, 113.0, 101.0, 117.0, 116.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 126.0, 143.0, 175.0, 118.0, 154.0, 154.0, 119.0, 185.0, 118.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 167.0, 163.0, 169.0, 168.0, 166.0, 165.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 79.0, 177.0, 75.0, 74.0, 75.0, 83.0, 180.0, 74.0], "value": 97.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 137.0, 80.0, 79.0, 89.0, 144.0, 82.0, 83.0, 137.0], "value": 99.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 114.0, 120.0, 115.0, 120.0, 116.0, 126.0, 115.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 149.0, 157.0, 149.0, 148.0, 151.0, 150.0, 158.0, 147.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 96.0, 98.0, 98.0, 106.0, 97.0, 94.0, 100.0, 97.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 52.0, 52.0, 62.0, 59.0, 59.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 48.0, 38.0, 39.0, 39.0, 40.0, 41.0, 40.0, 44.0, 39.0], "value": 42.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 74.0, 79.0, 82.0, 76.0, 75.0, 78.0, 79.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 127.0, 131.0, 139.0, 121.0, 125.0, 116.0, 118.0, 167.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 169.0, 180.0, 174.0, 179.0, 183.0, 170.0, 172.0, 167.0, 170.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 71.0, 63.0, 64.0, 65.0, 63.0], "value": 65.0, "unit": "score"}]}]} 03:17:35 INFO - Return code: 0 03:17:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:35 INFO - # TBPL SUCCESS # 03:17:35 INFO - Running post-action listener: _package_coverage_data 03:17:35 INFO - Running post-action listener: _resource_record_post_action 03:17:35 INFO - [mozharness: 2017-09-02 10:17:35.650495Z] Finished run-tests step (success) 03:17:35 INFO - Running post-run listener: _resource_record_post_run 03:17:35 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 536576; Write bytes: 397361152; Read time: 404; Write time: 501632 03:17:35 INFO - TinderboxPrint: CPU usage
13.3% 03:17:35 INFO - TinderboxPrint: I/O read bytes / time
536,576 / 404 03:17:35 INFO - TinderboxPrint: I/O write bytes / time
397,361,152 / 501,632 03:17:35 INFO - TinderboxPrint: CPU idle
8,251.5 (86.6%) 03:17:35 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 03:17:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 116629504; Read time: 0; Write time: 135548 03:17:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:17:35 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 536576; Write bytes: 280731648; Read time: 404; Write time: 366084 03:17:36 INFO - Running post-run listener: _upload_blobber_files 03:17:36 INFO - Blob upload gear active. 03:17:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:17:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:17:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:17:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:37 INFO - (blobuploader) - INFO - Done attempting. 03:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:17:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:45 INFO - (blobuploader) - INFO - Done attempting. 03:17:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:17:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:17:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:46 INFO - (blobuploader) - INFO - Done attempting. 03:17:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:17:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:17:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:47 INFO - (blobuploader) - INFO - Done attempting. 03:17:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:47 INFO - Return code: 0 03:17:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc3d40395b347a291a013651d1719e96a791f3e28281f69a39d538e5ec45b813f4383d6d0b56a3360d58ebc585b1fa3c1a215031552a7e6df4e8de37a84f29b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1967dfe922e5a03903ef81ffcad830a8ecaef282d09ec6f23b0b8e2e01682bc4cb5cce84875eb5c15092be85c027bdcc996df1fdc978be38c2a39cbd71b3df7f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e08397f5a63c60f8711aa2c513350ecdf5b77e012c4d5be1bf2372d7d72031e1225b55a15acea485c4e5b97509906aeeabdf12331ed4f5573643b586a511988", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0b648723893b0a7fc60a1ecba048892359b3f375acb6586376ed70d4249e6bd7c9a1749c7d283341fd8635ef4b1d7bbc69376259639c7390bf8629eba3335"} 03:17:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:47 INFO - Contents: 03:17:47 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc3d40395b347a291a013651d1719e96a791f3e28281f69a39d538e5ec45b813f4383d6d0b56a3360d58ebc585b1fa3c1a215031552a7e6df4e8de37a84f29b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1967dfe922e5a03903ef81ffcad830a8ecaef282d09ec6f23b0b8e2e01682bc4cb5cce84875eb5c15092be85c027bdcc996df1fdc978be38c2a39cbd71b3df7f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e08397f5a63c60f8711aa2c513350ecdf5b77e012c4d5be1bf2372d7d72031e1225b55a15acea485c4e5b97509906aeeabdf12331ed4f5573643b586a511988", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0b648723893b0a7fc60a1ecba048892359b3f375acb6586376ed70d4249e6bd7c9a1749c7d283341fd8635ef4b1d7bbc69376259639c7390bf8629eba3335"} 03:17:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:47 INFO - Copying logs to upload dir... 03:17:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.540455 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-09-02 03:17:47.441544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 03:17:47.445157) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc3d40395b347a291a013651d1719e96a791f3e28281f69a39d538e5ec45b813f4383d6d0b56a3360d58ebc585b1fa3c1a215031552a7e6df4e8de37a84f29b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1967dfe922e5a03903ef81ffcad830a8ecaef282d09ec6f23b0b8e2e01682bc4cb5cce84875eb5c15092be85c027bdcc996df1fdc978be38c2a39cbd71b3df7f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e08397f5a63c60f8711aa2c513350ecdf5b77e012c4d5be1bf2372d7d72031e1225b55a15acea485c4e5b97509906aeeabdf12331ed4f5573643b586a511988", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0b648723893b0a7fc60a1ecba048892359b3f375acb6586376ed70d4249e6bd7c9a1749c7d283341fd8635ef4b1d7bbc69376259639c7390bf8629eba3335"} build_url:https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/elhbt6dOSlyDfLTG7lCKow/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdc3d40395b347a291a013651d1719e96a791f3e28281f69a39d538e5ec45b813f4383d6d0b56a3360d58ebc585b1fa3c1a215031552a7e6df4e8de37a84f29b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1967dfe922e5a03903ef81ffcad830a8ecaef282d09ec6f23b0b8e2e01682bc4cb5cce84875eb5c15092be85c027bdcc996df1fdc978be38c2a39cbd71b3df7f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e08397f5a63c60f8711aa2c513350ecdf5b77e012c4d5be1bf2372d7d72031e1225b55a15acea485c4e5b97509906aeeabdf12331ed4f5573643b586a511988", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0d0b648723893b0a7fc60a1ecba048892359b3f375acb6586376ed70d4249e6bd7c9a1749c7d283341fd8635ef4b1d7bbc69376259639c7390bf8629eba3335"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 03:17:47.471460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 03:17:47.471799) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1504346204.152879-1084702759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 03:17:47.554045) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 03:17:47.554377) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 03:17:47.554694) ========= ========= Total master_lag: 0.19 =========