builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1504651958.97 results: success (0) revision: 978d2539a8d1a49e9f9705204f3918772b337547 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:38.969655) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:38.970127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:38.970409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:38.987779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:38.988086) ========= 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=eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-05 15:52:38-- 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% 97.8M=0s 2017-09-05 15:52:39 (97.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.243885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:39.253336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:39.253842) ========= 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=eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019880 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:39.306892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-05 15:52:39.308227) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 978d2539a8d1a49e9f9705204f3918772b337547 --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 978d2539a8d1a49e9f9705204f3918772b337547 --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=eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-05 15:52:39,275 truncating revision to first 12 chars 2017-09-05 15:52:39,276 Setting DEBUG logging. 2017-09-05 15:52:39,276 attempt 1/10 2017-09-05 15:52:39,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/978d2539a8d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-05 15:52:40,253 unpacking tar archive at: mozilla-central-978d2539a8d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.353376 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-05 15:52:40.677874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:40.681203) ========= script_repo_revision: 978d2539a8d1a49e9f9705204f3918772b337547 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:40.681573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:40.681830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 15:52:40.695118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-05 15:52:40.695402) ========= /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=eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:52:40 INFO - MultiFileLogger online at 20170905 15:52:40 in /builds/slave/test 15:52:40 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 15:52:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:40 INFO - {'append_to_log': False, 15:52:40 INFO - 'base_work_dir': '/builds/slave/test', 15:52:40 INFO - 'blob_upload_branch': 'Firefox', 15:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:40 INFO - 'branch': 'Firefox', 15:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:40 INFO - 'code_coverage': False, 15:52:40 INFO - 'config_files': ('talos/linux_config.py',), 15:52:40 INFO - 'default_actions': ('clobber', 15:52:40 INFO - 'read-buildbot-config', 15:52:40 INFO - 'download-and-extract', 15:52:40 INFO - 'populate-webroot', 15:52:40 INFO - 'create-virtualenv', 15:52:40 INFO - 'install', 15:52:40 INFO - 'setup-mitmproxy', 15:52:40 INFO - 'run-tests'), 15:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:40 INFO - 'disable_ccov_upload': False, 15:52:40 INFO - 'disable_stylo': False, 15:52:40 INFO - 'download_minidump_stackwalk': True, 15:52:40 INFO - 'download_symbols': 'ondemand', 15:52:40 INFO - 'enable_stylo': False, 15:52:40 INFO - 'enable_webrender': False, 15:52:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:40 INFO - 'gecko_profile': False, 15:52:40 INFO - 'gecko_profile_interval': 0, 15:52:40 INFO - 'installer_path': 'installer.exe', 15:52:40 INFO - 'log_level': 'info', 15:52:40 INFO - 'log_name': 'talos', 15:52:40 INFO - 'log_to_console': True, 15:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:52:40 INFO - 'opt_config_files': (), 15:52:40 INFO - 'pip_index': False, 15:52:40 INFO - 'suite': 'dromaeojs-e10s', 15:52:40 INFO - 'system_bits': '32', 15:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:40 INFO - 'title': 'talos-linux64-ix-010', 15:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:40 INFO - 'use_talos_json': True, 15:52:40 INFO - 'verify': 'False', 15:52:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:40 INFO - 'work_dir': 'build'} 15:52:40 INFO - [mozharness: 2017-09-05 22:52:40.812990Z] Running clobber step. 15:52:40 INFO - Running pre-action listener: _resource_record_pre_action 15:52:40 INFO - Running main action method: clobber 15:52:40 INFO - rmtree: /builds/slave/test/build 15:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:41 INFO - Running post-action listener: _resource_record_post_action 15:52:41 INFO - [mozharness: 2017-09-05 22:52:41.846964Z] Finished clobber step (success) 15:52:41 INFO - [mozharness: 2017-09-05 22:52:41.847061Z] Running read-buildbot-config step. 15:52:41 INFO - Running pre-action listener: _resource_record_pre_action 15:52:41 INFO - Running main action method: read_buildbot_config 15:52:41 INFO - Using buildbot properties: 15:52:41 INFO - { 15:52:41 INFO - "project": "", 15:52:41 INFO - "product": "firefox", 15:52:41 INFO - "who": "archaeopteryx@coole-files.de", 15:52:41 INFO - "installer_path": "public/build/target.tar.bz2", 15:52:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:52:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:52:41 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:52:41 INFO - "stage_platform": "linux64-qr", 15:52:41 INFO - "basedir": "/builds/slave/test", 15:52:41 INFO - "buildnumber": 35, 15:52:41 INFO - "platform": "ubuntu64_hw_qr", 15:52:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:52:41 INFO - "slavebuilddir": "test", 15:52:41 INFO - "taskId": "VvSNMv_kRb2551HS_uzLzw", 15:52:41 INFO - "branch": "mozilla-central", 15:52:41 INFO - "script_repo_revision": "production", 15:52:41 INFO - "revision": "978d2539a8d1a49e9f9705204f3918772b337547", 15:52:41 INFO - "slavename": "talos-linux64-ix-010", 15:52:41 INFO - "repo_path": "mozilla-central" 15:52:41 INFO - } 15:52:41 INFO - Finding installer, test and symbols from parent task. 15:52:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VvSNMv_kRb2551HS_uzLzw'}, attempt #1 15:52:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VvSNMv_kRb2551HS_uzLzw'}, attempt #1 15:52:42 INFO - Task dependencies: ciQLVfAyTVS5ODxEPFePfg 15:52:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg'}, attempt #1 15:52:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2 15:52:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.test_packages.json 15:52:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.crashreporter-symbols.zip 15:52:43 INFO - Running post-action listener: _resource_record_post_action 15:52:43 INFO - [mozharness: 2017-09-05 22:52:43.237630Z] Finished read-buildbot-config step (success) 15:52:43 INFO - [mozharness: 2017-09-05 22:52:43.237848Z] Running download-and-extract step. 15:52:43 INFO - Running pre-action listener: _resource_record_pre_action 15:52:43 INFO - Running main action method: download_and_extract 15:52:43 INFO - mkdir: /builds/slave/test/build/tests 15:52:43 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')]} 15:52:43 INFO - trying https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.test_packages.json 15:52:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:52:43 INFO - Downloaded 989 bytes. 15:52:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:52:43 INFO - Using the following test package requirements: 15:52:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:52:43 INFO - u'common': [u'target.common.tests.zip'], 15:52:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:52:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:52:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:52:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:52:43 INFO - u'mozbase': [u'target.common.tests.zip'], 15:52:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:52:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:52:43 INFO - u'web-platform': [u'target.common.tests.zip', 15:52:43 INFO - u'target.web-platform.tests.tar.gz'], 15:52:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:52:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.common.tests.zip 15:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.common.tests.zip into memory 15:52:44 INFO - Content-Length response header: 55019957 15:52:44 INFO - Bytes received: 55019957 15:52:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:52:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.common.tests.zip 15:52:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:52:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.common.tests.zip into memory 15:52:57 INFO - Content-Length response header: 55019957 15:52:57 INFO - Bytes received: 55019957 15:53:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.talos.tests.zip 15:53:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:53:09 INFO - Fetch https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.talos.tests.zip into memory 15:53:09 INFO - Content-Length response header: 14496654 15:53:09 INFO - Bytes received: 14496654 15:53:10 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')]} 15:53:10 INFO - trying https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2 15:53:10 INFO - Downloading https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:53:11 INFO - Downloaded 62666628 bytes. 15:53:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2 15:53:11 INFO - mkdir: /builds/slave/test/properties 15:53:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:11 INFO - Contents: 15:53:11 INFO - build_url:https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2 15:53:11 INFO - Running post-action listener: _resource_record_post_action 15:53:11 INFO - Running post-action listener: find_tests_for_verification 15:53:11 INFO - Running post-action listener: set_extra_try_arguments 15:53:11 INFO - [mozharness: 2017-09-05 22:53:11.243799Z] Finished download-and-extract step (success) 15:53:11 INFO - [mozharness: 2017-09-05 22:53:11.243894Z] Running populate-webroot step. 15:53:11 INFO - Running pre-action listener: _resource_record_pre_action 15:53:11 INFO - Running main action method: populate_webroot 15:53:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:11 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:11 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:11 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'tests': ['damp', 'tps']}, 15:53:11 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['damp', 'tps']}, 15:53:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:53:11 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:53:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:53:11 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:53:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:11 INFO - 'ts_paint', 15:53:11 INFO - 'tpaint', 15:53:11 INFO - 'sessionrestore', 15:53:11 INFO - 'sessionrestore_many_windows', 15:53:11 INFO - 'sessionrestore_no_auto_restore', 15:53:11 INFO - 'tabpaint']}, 15:53:11 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['a11yr', 15:53:11 INFO - 'ts_paint', 15:53:11 INFO - 'tpaint', 15:53:11 INFO - 'sessionrestore', 15:53:11 INFO - 'sessionrestore_many_windows', 15:53:11 INFO - 'sessionrestore_no_auto_restore', 15:53:11 INFO - 'tabpaint']}, 15:53:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:53:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:53:11 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['bloom_basic_singleton']}, 15:53:11 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['bloom_basic']}, 15:53:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:11 INFO - 'tsvgr_opacity', 15:53:11 INFO - 'tart', 15:53:11 INFO - 'tscrollx', 15:53:11 INFO - 'tsvg_static']}, 15:53:11 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['tsvgx', 15:53:11 INFO - 'tsvgr_opacity', 15:53:11 INFO - 'tart', 15:53:11 INFO - 'tscrollx', 15:53:11 INFO - 'tsvg_static']}, 15:53:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:53:11 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo'], 15:53:11 INFO - 'tests': ['tp5o']}, 15:53:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:11 INFO - 'talos_options': ['--mitmproxy', 15:53:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:11 INFO - '--firstNonBlankPaint'], 15:53:11 INFO - 'tests': ['tp6_google', 15:53:11 INFO - 'tp6_youtube', 15:53:11 INFO - 'tp6_amazon', 15:53:11 INFO - 'tp6_facebook']}, 15:53:11 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo', 15:53:11 INFO - '--mitmproxy', 15:53:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:11 INFO - '--firstNonBlankPaint'], 15:53:11 INFO - 'tests': ['tp6_google', 15:53:11 INFO - 'tp6_youtube', 15:53:11 INFO - 'tp6_amazon', 15:53:11 INFO - 'tp6_facebook']}, 15:53:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo', 15:53:11 INFO - '--stylo-threads=1', 15:53:11 INFO - '--mitmproxy', 15:53:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:11 INFO - '--firstNonBlankPaint'], 15:53:11 INFO - 'tests': ['tp6_google', 15:53:11 INFO - 'tp6_youtube', 15:53:11 INFO - 'tp6_amazon', 15:53:11 INFO - 'tp6_facebook']}, 15:53:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'talos_options': ['--xperf_path', 15:53:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:11 INFO - 'tests': ['tp5n']}, 15:53:11 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:53:11 INFO - 'talos_options': ['--enable-stylo', 15:53:11 INFO - '--xperf_path', 15:53:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:11 INFO - 'tests': ['tp5n']}}} 15:53:11 INFO - Running post-action listener: _resource_record_post_action 15:53:11 INFO - [mozharness: 2017-09-05 22:53:11.258185Z] Finished populate-webroot step (success) 15:53:11 INFO - [mozharness: 2017-09-05 22:53:11.258274Z] Running create-virtualenv step. 15:53:11 INFO - Running pre-action listener: _resource_record_pre_action 15:53:11 INFO - Running main action method: create_virtualenv 15:53:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:11 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:53:11 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:53:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:53:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:12 INFO - Installing pip...............done. 15:53:12 INFO - Return code: 0 15:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:53:12 INFO - Reading from file tmpfile_stdout 15:53:12 INFO - Output received: 15:53:12 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:53:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:12 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')]} 15:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:12 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')]} 15:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:12 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 15:53:12 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 15:53:12 INFO - Using env: {'DISPLAY': ':0', 15:53:12 INFO - 'HOME': '/home/cltbld', 15:53:12 INFO - 'LANG': 'en_US.UTF-8', 15:53:12 INFO - 'LANGUAGE': 'en_US:en', 15:53:12 INFO - 'LOGNAME': 'cltbld', 15:53:12 INFO - 'MAIL': '/var/mail/cltbld', 15:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:12 INFO - 'MOZ_NO_REMOTE': '1', 15:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:12 INFO - 'NO_EM_RESTART': '1', 15:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:12 INFO - 'PWD': '/builds/slave/test', 15:53:12 INFO - 'SHELL': '/bin/bash', 15:53:12 INFO - 'SHLVL': '1', 15:53:12 INFO - 'TERM': 'linux', 15:53:12 INFO - 'TMOUT': '86400', 15:53:12 INFO - 'USER': 'cltbld', 15:53:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:12 INFO - '_': '/tools/buildbot/bin/python'} 15:53:13 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:53:13 INFO - Downloading/unpacking pip>=1.5 15:53:13 INFO - Running setup.py egg_info for package pip 15:53:13 INFO - warning: no files found matching 'pip/cacert.pem' 15:53:13 INFO - warning: no files found matching '*.html' under directory 'docs' 15:53:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:53:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:53:13 INFO - Installing collected packages: pip 15:53:13 INFO - Found existing installation: pip 1.1 15:53:13 INFO - Uninstalling pip: 15:53:13 INFO - Successfully uninstalled pip 15:53:13 INFO - Running setup.py install for pip 15:53:13 INFO - warning: no files found matching 'pip/cacert.pem' 15:53:13 INFO - warning: no files found matching '*.html' under directory 'docs' 15:53:13 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:53:13 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:53:13 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:53:13 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:53:13 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:53:13 INFO - Successfully installed pip 15:53:13 INFO - Cleaning up... 15:53:13 INFO - Return code: 0 15:53:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:13 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')]} 15:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:13 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')]} 15:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:13 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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:13 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 15:53:13 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 15:53:13 INFO - Using env: {'DISPLAY': ':0', 15:53:13 INFO - 'HOME': '/home/cltbld', 15:53:13 INFO - 'LANG': 'en_US.UTF-8', 15:53:13 INFO - 'LANGUAGE': 'en_US:en', 15:53:13 INFO - 'LOGNAME': 'cltbld', 15:53:13 INFO - 'MAIL': '/var/mail/cltbld', 15:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:13 INFO - 'MOZ_NO_REMOTE': '1', 15:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:13 INFO - 'NO_EM_RESTART': '1', 15:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:13 INFO - 'PWD': '/builds/slave/test', 15:53:13 INFO - 'SHELL': '/bin/bash', 15:53:13 INFO - 'SHLVL': '1', 15:53:13 INFO - 'TERM': 'linux', 15:53:13 INFO - 'TMOUT': '86400', 15:53:13 INFO - 'USER': 'cltbld', 15:53:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:13 INFO - '_': '/tools/buildbot/bin/python'} 15:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:13 INFO - Downloading/unpacking psutil>=3.1.1 15:53:13 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 15:53:13 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 15:53:13 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 15:53:13 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 15:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:14 INFO - Installing collected packages: psutil 15:53:14 INFO - Running setup.py install for psutil 15:53:14 INFO - building 'psutil._psutil_linux' extension 15:53:14 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 15:53:15 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 15:53:15 INFO - building 'psutil._psutil_posix' extension 15:53:15 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 15:53:15 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 15:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:15 INFO - Successfully installed psutil 15:53:15 INFO - Cleaning up... 15:53:15 INFO - Return code: 0 15:53:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:15 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')]} 15:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:15 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')]} 15:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:15 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 15:53:15 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 15:53:15 INFO - Using env: {'DISPLAY': ':0', 15:53:15 INFO - 'HOME': '/home/cltbld', 15:53:15 INFO - 'LANG': 'en_US.UTF-8', 15:53:15 INFO - 'LANGUAGE': 'en_US:en', 15:53:15 INFO - 'LOGNAME': 'cltbld', 15:53:15 INFO - 'MAIL': '/var/mail/cltbld', 15:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:15 INFO - 'MOZ_NO_REMOTE': '1', 15:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:15 INFO - 'NO_EM_RESTART': '1', 15:53:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:15 INFO - 'PWD': '/builds/slave/test', 15:53:15 INFO - 'SHELL': '/bin/bash', 15:53:15 INFO - 'SHLVL': '1', 15:53:15 INFO - 'TERM': 'linux', 15:53:15 INFO - 'TMOUT': '86400', 15:53:15 INFO - 'USER': 'cltbld', 15:53:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:15 INFO - '_': '/tools/buildbot/bin/python'} 15:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:16 INFO - Installing collected packages: mozsystemmonitor 15:53:16 INFO - Running setup.py install for mozsystemmonitor 15:53:16 INFO - Successfully installed mozsystemmonitor 15:53:16 INFO - Cleaning up... 15:53:16 INFO - Return code: 0 15:53:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:16 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')]} 15:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:16 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')]} 15:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:16 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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:16 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 15:53:16 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 15:53:16 INFO - Using env: {'DISPLAY': ':0', 15:53:16 INFO - 'HOME': '/home/cltbld', 15:53:16 INFO - 'LANG': 'en_US.UTF-8', 15:53:16 INFO - 'LANGUAGE': 'en_US:en', 15:53:16 INFO - 'LOGNAME': 'cltbld', 15:53:16 INFO - 'MAIL': '/var/mail/cltbld', 15:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:16 INFO - 'MOZ_NO_REMOTE': '1', 15:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:16 INFO - 'NO_EM_RESTART': '1', 15:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:16 INFO - 'PWD': '/builds/slave/test', 15:53:16 INFO - 'SHELL': '/bin/bash', 15:53:16 INFO - 'SHLVL': '1', 15:53:16 INFO - 'TERM': 'linux', 15:53:16 INFO - 'TMOUT': '86400', 15:53:16 INFO - 'USER': 'cltbld', 15:53:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:16 INFO - '_': '/tools/buildbot/bin/python'} 15:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:17 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:18 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:18 INFO - warning: no files found matching '*.txt' 15:53:18 INFO - no previously-included directories found matching 'build' 15:53:18 INFO - no previously-included directories found matching 'dist' 15:53:18 INFO - no previously-included directories found matching '.git*' 15:53:18 INFO - Installing collected packages: jsonschema, functools32 15:53:18 INFO - Running setup.py install for functools32 15:53:18 INFO - warning: no files found matching '*.txt' 15:53:18 INFO - no previously-included directories found matching 'build' 15:53:18 INFO - no previously-included directories found matching 'dist' 15:53:18 INFO - no previously-included directories found matching '.git*' 15:53:18 INFO - Successfully installed jsonschema functools32 15:53:18 INFO - Cleaning up... 15:53:18 INFO - Return code: 0 15:53:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:18 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')]} 15:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:18 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')]} 15:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:18 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 15:53:18 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 15:53:18 INFO - Using env: {'DISPLAY': ':0', 15:53:18 INFO - 'HOME': '/home/cltbld', 15:53:18 INFO - 'LANG': 'en_US.UTF-8', 15:53:18 INFO - 'LANGUAGE': 'en_US:en', 15:53:18 INFO - 'LOGNAME': 'cltbld', 15:53:18 INFO - 'MAIL': '/var/mail/cltbld', 15:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:18 INFO - 'MOZ_NO_REMOTE': '1', 15:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:18 INFO - 'NO_EM_RESTART': '1', 15:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:18 INFO - 'PWD': '/builds/slave/test', 15:53:18 INFO - 'SHELL': '/bin/bash', 15:53:18 INFO - 'SHLVL': '1', 15:53:18 INFO - 'TERM': 'linux', 15:53:18 INFO - 'TMOUT': '86400', 15:53:18 INFO - 'USER': 'cltbld', 15:53:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:18 INFO - '_': '/tools/buildbot/bin/python'} 15:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:18 INFO - Cleaning up... 15:53:18 INFO - Return code: 0 15:53:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:18 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')]} 15:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:18 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')]} 15:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:18 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 15:53:18 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 15:53:18 INFO - Using env: {'DISPLAY': ':0', 15:53:18 INFO - 'HOME': '/home/cltbld', 15:53:18 INFO - 'LANG': 'en_US.UTF-8', 15:53:18 INFO - 'LANGUAGE': 'en_US:en', 15:53:18 INFO - 'LOGNAME': 'cltbld', 15:53:18 INFO - 'MAIL': '/var/mail/cltbld', 15:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:18 INFO - 'MOZ_NO_REMOTE': '1', 15:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:18 INFO - 'NO_EM_RESTART': '1', 15:53:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:18 INFO - 'PWD': '/builds/slave/test', 15:53:18 INFO - 'SHELL': '/bin/bash', 15:53:18 INFO - 'SHLVL': '1', 15:53:18 INFO - 'TERM': 'linux', 15:53:18 INFO - 'TMOUT': '86400', 15:53:18 INFO - 'USER': 'cltbld', 15:53:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:18 INFO - '_': '/tools/buildbot/bin/python'} 15:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:19 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - Downloading docopt-0.6.1.tar.gz 15:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:20 INFO - Running setup.py install for blobuploader 15:53:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:20 INFO - Running setup.py install for requests 15:53:21 INFO - Running setup.py install for docopt 15:53:21 INFO - Successfully installed blobuploader requests docopt 15:53:21 INFO - Cleaning up... 15:53:21 INFO - Return code: 0 15:53:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53: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')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:21 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 15:53:21 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 15:53:21 INFO - Using env: {'DISPLAY': ':0', 15:53:21 INFO - 'HOME': '/home/cltbld', 15:53:21 INFO - 'LANG': 'en_US.UTF-8', 15:53:21 INFO - 'LANGUAGE': 'en_US:en', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MAIL': '/var/mail/cltbld', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SHLVL': '1', 15:53:21 INFO - 'TERM': 'linux', 15:53:21 INFO - 'TMOUT': '86400', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - '_': '/tools/buildbot/bin/python'} 15:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:21 INFO - Running setup.py (path:/tmp/pip-92f_CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:21 INFO - Running setup.py (path:/tmp/pip-MATB67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:21 INFO - Running setup.py (path:/tmp/pip-nseXW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:21 INFO - Running setup.py (path:/tmp/pip-TXEqJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:21 INFO - Running setup.py (path:/tmp/pip-P5Ui9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:21 INFO - Running setup.py (path:/tmp/pip-_TVw9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:21 INFO - Running setup.py (path:/tmp/pip-FTWDBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:22 INFO - Running setup.py (path:/tmp/pip-ZgReFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:22 INFO - Running setup.py (path:/tmp/pip-4x9kWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:22 INFO - Running setup.py (path:/tmp/pip-4SnlXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:22 INFO - Running setup.py (path:/tmp/pip-WjRnR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:22 INFO - Running setup.py (path:/tmp/pip-n2Fqjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:22 INFO - Running setup.py (path:/tmp/pip-m0Wip4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:22 INFO - Running setup.py (path:/tmp/pip-Gj4Xzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:22 INFO - Running setup.py (path:/tmp/pip-t3htLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:22 INFO - Running setup.py (path:/tmp/pip-hTWnwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:22 INFO - Running setup.py (path:/tmp/pip-DpEBJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:22 INFO - Running setup.py install for manifestparser 15:53:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:22 INFO - Running setup.py install for mozcrash 15:53:22 INFO - Running setup.py install for mozdebug 15:53:23 INFO - Running setup.py install for mozdevice 15:53:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Running setup.py install for mozfile 15:53:23 INFO - Running setup.py install for mozhttpd 15:53:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Running setup.py install for mozinfo 15:53:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Running setup.py install for mozInstall 15:53:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Running setup.py install for mozleak 15:53:23 INFO - Running setup.py install for mozlog 15:53:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Running setup.py install for moznetwork 15:53:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:23 INFO - Running setup.py install for mozprocess 15:53:23 INFO - Running setup.py install for mozprofile 15:53:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:24 INFO - Running setup.py install for mozrunner 15:53:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:24 INFO - Running setup.py install for mozscreenshot 15:53:24 INFO - Running setup.py install for moztest 15:53:24 INFO - Running setup.py install for mozversion 15:53:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:24 INFO - Cleaning up... 15:53:24 INFO - Return code: 0 15:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53: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')]} 15:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:24 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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:24 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 15:53:24 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 15:53:24 INFO - Using env: {'DISPLAY': ':0', 15:53:24 INFO - 'HOME': '/home/cltbld', 15:53:24 INFO - 'LANG': 'en_US.UTF-8', 15:53:24 INFO - 'LANGUAGE': 'en_US:en', 15:53:24 INFO - 'LOGNAME': 'cltbld', 15:53:24 INFO - 'MAIL': '/var/mail/cltbld', 15:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:24 INFO - 'MOZ_NO_REMOTE': '1', 15:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:24 INFO - 'NO_EM_RESTART': '1', 15:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:24 INFO - 'PWD': '/builds/slave/test', 15:53:24 INFO - 'SHELL': '/bin/bash', 15:53:24 INFO - 'SHLVL': '1', 15:53:24 INFO - 'TERM': 'linux', 15:53:24 INFO - 'TMOUT': '86400', 15:53:24 INFO - 'USER': 'cltbld', 15:53:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:24 INFO - '_': '/tools/buildbot/bin/python'} 15:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:24 INFO - Running setup.py (path:/tmp/pip-v5OhI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:24 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)) 15:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:24 INFO - Running setup.py (path:/tmp/pip-doEt8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:24 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)) 15:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:24 INFO - Running setup.py (path:/tmp/pip-lCqUkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:24 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)) 15:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:24 INFO - Running setup.py (path:/tmp/pip-0_hFrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:24 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)) 15:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:24 INFO - Running setup.py (path:/tmp/pip-HmktWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:25 INFO - Running setup.py (path:/tmp/pip-b2H6dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:25 INFO - Running setup.py (path:/tmp/pip-EBc5JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:25 INFO - Running setup.py (path:/tmp/pip-ZAJ23W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:25 INFO - Running setup.py (path:/tmp/pip-fKWBrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:25 INFO - Running setup.py (path:/tmp/pip-qRVtm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:25 INFO - Running setup.py (path:/tmp/pip-wQqYTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:25 INFO - Running setup.py (path:/tmp/pip-PTesmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:25 INFO - Running setup.py (path:/tmp/pip-zCO48R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:25 INFO - Running setup.py (path:/tmp/pip-5hTeAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:25 INFO - Running setup.py (path:/tmp/pip-ZcXCIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:25 INFO - Running setup.py (path:/tmp/pip-2GVThJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:25 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)) 15:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:25 INFO - Running setup.py (path:/tmp/pip-jMQIvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:25 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)) 15:53:25 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)) 15:53:25 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)) 15:53:25 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)) 15:53:25 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)) 15:53:25 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)) 15:53:25 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)) 15:53:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53: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 15:53: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 15:53: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 15:53: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 15:53:27 INFO - Downloading blessings-1.6.tar.gz 15:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:27 INFO - Installing collected packages: blessings 15:53:27 INFO - Running setup.py install for blessings 15:53:27 INFO - Successfully installed blessings 15:53:27 INFO - Cleaning up... 15:53:27 INFO - Return code: 0 15:53:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:27 INFO - Reading from file tmpfile_stdout 15:53:27 INFO - Current package versions: 15:53:27 INFO - argparse == 1.2.1 15:53:27 INFO - blessings == 1.6 15:53:27 INFO - blobuploader == 1.2.4 15:53:27 INFO - docopt == 0.6.1 15:53:27 INFO - functools32 == 3.2.3-2 15:53:27 INFO - jsonschema == 2.5.1 15:53:27 INFO - manifestparser == 1.1 15:53:27 INFO - mozInstall == 1.13 15:53:27 INFO - mozcrash == 1.0 15:53:27 INFO - mozdebug == 0.1 15:53:27 INFO - mozdevice == 0.51 15:53:27 INFO - mozfile == 1.2 15:53:27 INFO - mozhttpd == 0.7 15:53:27 INFO - mozinfo == 0.10 15:53:27 INFO - mozleak == 0.1 15:53:27 INFO - mozlog == 3.5 15:53:27 INFO - moznetwork == 0.27 15:53:27 INFO - mozprocess == 0.25 15:53:27 INFO - mozprofile == 0.28 15:53:27 INFO - mozrunner == 6.13 15:53:27 INFO - mozscreenshot == 0.1 15:53:27 INFO - mozsystemmonitor == 0.3 15:53:27 INFO - moztest == 0.8 15:53:27 INFO - mozversion == 1.4 15:53:27 INFO - psutil == 3.1.1 15:53:27 INFO - requests == 1.2.3 15:53:27 INFO - wsgiref == 0.1.2 15:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53: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')]} 15:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:27 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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:27 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 15:53:27 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 15:53:27 INFO - Using env: {'DISPLAY': ':0', 15:53:27 INFO - 'HOME': '/home/cltbld', 15:53:27 INFO - 'LANG': 'en_US.UTF-8', 15:53:27 INFO - 'LANGUAGE': 'en_US:en', 15:53:27 INFO - 'LOGNAME': 'cltbld', 15:53:27 INFO - 'MAIL': '/var/mail/cltbld', 15:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:27 INFO - 'MOZ_NO_REMOTE': '1', 15:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:27 INFO - 'NO_EM_RESTART': '1', 15:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:27 INFO - 'PWD': '/builds/slave/test', 15:53:27 INFO - 'SHELL': '/bin/bash', 15:53:27 INFO - 'SHLVL': '1', 15:53:27 INFO - 'TERM': 'linux', 15:53:27 INFO - 'TMOUT': '86400', 15:53:27 INFO - 'USER': 'cltbld', 15:53:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:27 INFO - '_': '/tools/buildbot/bin/python'} 15:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 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)) 15:53:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:53: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 15:53: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 15:53: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 15:53: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 15:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:53:28 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)) 15:53:28 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)) 15:53:28 INFO - Installing collected packages: simplejson 15:53:28 INFO - Running setup.py install for simplejson 15:53:28 INFO - building 'simplejson._speedups' extension 15:53:28 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 15:53:29 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 15:53:29 INFO - Successfully installed simplejson 15:53:29 INFO - Cleaning up... 15:53:29 INFO - Return code: 0 15:53:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:29 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')]} 15:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:29 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')]} 15:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:29 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 0x18791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', '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 15:53:29 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 15:53:29 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 15:53:29 INFO - Using env: {'DISPLAY': ':0', 15:53:29 INFO - 'HOME': '/home/cltbld', 15:53:29 INFO - 'LANG': 'en_US.UTF-8', 15:53:29 INFO - 'LANGUAGE': 'en_US:en', 15:53:29 INFO - 'LOGNAME': 'cltbld', 15:53:29 INFO - 'MAIL': '/var/mail/cltbld', 15:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:29 INFO - 'MOZ_NO_REMOTE': '1', 15:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:29 INFO - 'NO_EM_RESTART': '1', 15:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:29 INFO - 'PWD': '/builds/slave/test', 15:53:29 INFO - 'SHELL': '/bin/bash', 15:53:29 INFO - 'SHLVL': '1', 15:53:29 INFO - 'TERM': 'linux', 15:53:29 INFO - 'TMOUT': '86400', 15:53:29 INFO - 'USER': 'cltbld', 15:53:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:29 INFO - '_': '/tools/buildbot/bin/python'} 15:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:30 INFO - Cleaning up... 15:53:30 INFO - Return code: 0 15:53:30 INFO - Running post-action listener: _resource_record_post_action 15:53:30 INFO - Running post-action listener: _start_resource_monitoring 15:53:30 INFO - Starting resource monitoring. 15:53:30 INFO - [mozharness: 2017-09-05 22:53:30.209189Z] Finished create-virtualenv step (success) 15:53:30 INFO - [mozharness: 2017-09-05 22:53:30.209661Z] Running install step. 15:53:30 INFO - Running pre-action listener: _resource_record_pre_action 15:53:30 INFO - Running main action method: install 15:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:30 INFO - Reading from file tmpfile_stdout 15:53:30 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:30 INFO - Reading from file tmpfile_stdout 15:53:30 INFO - Output received: 15:53:30 INFO - Usage: mozinstall [options] installer 15:53:30 INFO - Options: 15:53:30 INFO - -h, --help show this help message and exit 15:53:30 INFO - -d DEST, --destination=DEST 15:53:30 INFO - Directory to install application into. [default: 15:53:30 INFO - "/builds/slave/test"] 15:53:30 INFO - --app=APP Application being installed. [default: firefox] 15:53:30 INFO - mkdir: /builds/slave/test/build/application 15:53:30 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'] 15:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:53:47 INFO - Reading from file tmpfile_stdout 15:53:47 INFO - Output received: 15:53:47 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:47 INFO - Running post-action listener: _resource_record_post_action 15:53:47 INFO - [mozharness: 2017-09-05 22:53:47.237666Z] Finished install step (success) 15:53:47 INFO - [mozharness: 2017-09-05 22:53:47.237773Z] Running setup-mitmproxy step. 15:53:47 INFO - Running pre-action listener: _resource_record_pre_action 15:53:47 INFO - Running main action method: setup_mitmproxy 15:53:47 INFO - Skipping: mitmproxy is not required 15:53:47 INFO - Running post-action listener: _resource_record_post_action 15:53:47 INFO - [mozharness: 2017-09-05 22:53:47.238242Z] Finished setup-mitmproxy step (success) 15:53:47 INFO - [mozharness: 2017-09-05 22:53:47.238332Z] Running run-tests step. 15:53:47 INFO - Running pre-action listener: _resource_record_pre_action 15:53:47 INFO - Running pre-action listener: _set_gcov_prefix 15:53:47 INFO - Running main action method: run_tests 15:53:47 WARNING - Try message not found. 15:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:47 INFO - Python 2.7.3 15:53:47 INFO - Return code: 0 15:53:47 INFO - grabbing minidump binary from tooltool 15:53:47 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')]} 15:53:47 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 0x1be9090>, '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 0x1be9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:47 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 15:53:47 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 15:53:47 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 15:53:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:47 INFO - Return code: 0 15:53:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:47 INFO - ENV: RUST_BACKTRACE is now full 15:53:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:47 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/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 15:53:47 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/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 15:53:47 INFO - Using env: {'DISPLAY': ':0', 15:53:47 INFO - 'HOME': '/home/cltbld', 15:53:47 INFO - 'LANG': 'en_US.UTF-8', 15:53:47 INFO - 'LANGUAGE': 'en_US:en', 15:53:47 INFO - 'LOGNAME': 'cltbld', 15:53:47 INFO - 'MAIL': '/var/mail/cltbld', 15:53:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:47 INFO - 'MOZ_ACCELERATED': '1', 15:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:47 INFO - 'MOZ_NO_REMOTE': '1', 15:53:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:47 INFO - 'MOZ_WEBRENDER': '1', 15:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:47 INFO - 'NO_EM_RESTART': '1', 15:53:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:47 INFO - 'PWD': '/builds/slave/test', 15:53:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:47 INFO - 'RUST_BACKTRACE': 'full', 15:53:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:53:47 INFO - 'SHELL': '/bin/bash', 15:53:47 INFO - 'SHLVL': '1', 15:53:47 INFO - 'TERM': 'linux', 15:53:47 INFO - 'TMOUT': '86400', 15:53:47 INFO - 'USER': 'cltbld', 15:53:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:47 INFO - '_': '/tools/buildbot/bin/python'} 15:53:47 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/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 15:53:47 INFO - mozversion application_buildid: 20170905215433 15:53:47 INFO - mozversion application_changeset: 978d2539a8d1a49e9f9705204f3918772b337547 15:53:47 INFO - mozversion application_display_name: Nightly 15:53:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:47 INFO - mozversion application_name: Firefox 15:53:47 INFO - mozversion application_remotingname: firefox 15:53:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:53:47 INFO - mozversion application_vendor: Mozilla 15:53:47 INFO - mozversion application_version: 57.0a1 15:53:47 INFO - mozversion platform_buildid: 20170905215433 15:53:47 INFO - mozversion platform_changeset: 978d2539a8d1a49e9f9705204f3918772b337547 15:53:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:53:47 INFO - mozversion platform_version: 57.0a1 15:53:47 INFO - using testdate: 1504652027 15:53:47 INFO - actual date: 1504652027 15:53:47 INFO - starting webserver on 'localhost:58444' 15:53:47 INFO - SUITE-START | Running 2 tests 15:53:47 INFO - TEST-START | dromaeo_css 15:53:47 INFO - Initialising browser for dromaeo_css test... 15:53:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58444/getInfo.html -profile /tmp/tmpYoCUay/profile 15:53:47 INFO - TEST-INFO | started process 13280 (/builds/slave/test/build/application/firefox/firefox http://localhost:58444/getInfo.html) 15:53:55 INFO - TEST-INFO | 13280: exit 0 15:53:55 INFO - Browser initialized. 15:53:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:55 INFO - Using env: {'DISPLAY': ':0', 15:53:55 INFO - 'HOME': '/home/cltbld', 15:53:55 INFO - 'JSGC_DISABLE_POISONING': '1', 15:53:55 INFO - 'LANG': 'en_US.UTF-8', 15:53:55 INFO - 'LANGUAGE': 'en_US:en', 15:53:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:53:55 INFO - 'LOGNAME': 'cltbld', 15:53:55 INFO - 'MAIL': '/var/mail/cltbld', 15:53:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:55 INFO - 'MOZ_ACCELERATED': '1', 15:53:55 INFO - 'MOZ_CRASHREPORTER': '1', 15:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:53:55 INFO - 'MOZ_NO_REMOTE': '1', 15:53:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:55 INFO - 'MOZ_WEBRENDER': '1', 15:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:55 INFO - 'NO_EM_RESTART': '1', 15:53:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:55 INFO - 'PWD': '/builds/slave/test', 15:53:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:55 INFO - 'RUST_BACKTRACE': 'full', 15:53:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:53:55 INFO - 'SHELL': '/bin/bash', 15:53:55 INFO - 'SHLVL': '1', 15:53:55 INFO - 'TERM': 'linux', 15:53:55 INFO - 'TMOUT': '86400', 15:53:55 INFO - 'USER': 'cltbld', 15:53:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 15:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:55 INFO - '_': '/tools/buildbot/bin/python'} 15:53:55 INFO - TEST-INFO | started process 13476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoCUay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:56 INFO - PID 13476 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:53:56 INFO - PID 13476 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:53:56 INFO - PID 13476 | 15:53:56 INFO - PID 13476 | (/builds/slave/test/build/application/firefox/firefox:13539): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:53:56 INFO - PID 13476 | 15:54:06 INFO - PID 13476 | RSS: Main: 203100160 15:54:06 INFO - PID 13476 | 15:54:10 INFO - PID 13476 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:57:05 INFO - PID 13476 | Cycle 1(1): loaded http://localhost:58444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58444/tests/dromaeo/cssquery-ext.html) 15:57:05 INFO - PID 13476 | RSS: Main: 215199744 15:57:05 INFO - PID 13476 | 16:00:08 INFO - PID 13476 | Cycle 1(1): loaded http://localhost:58444/tests/dromaeo/cssquery-ext.html (next: http://localhost:58444/tests/dromaeo/cssquery-jquery.html) 16:00:08 INFO - PID 13476 | RSS: Main: 212930560 16:00:08 INFO - PID 13476 | 16:03:10 INFO - PID 13476 | Cycle 1(1): loaded http://localhost:58444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58444/tests/dromaeo/cssquery-mootools.html) 16:03:11 INFO - PID 13476 | RSS: Main: 214855680 16:03:11 INFO - PID 13476 | 16:06:13 INFO - PID 13476 | Cycle 1(1): loaded http://localhost:58444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58444/tests/dromaeo/cssquery-prototype.html) 16:06:14 INFO - PID 13476 | RSS: Main: 213528576 16:06:14 INFO - PID 13476 | 16:09:18 INFO - PID 13476 | Cycle 1(1): loaded http://localhost:58444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58444/tests/dromaeo/cssquery-yui.html) 16:09:18 INFO - PID 13476 | RSS: Main: 214773760 16:09:18 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | Cycle 1(1): loaded http://localhost:58444/tests/dromaeo/cssquery-yui.html (next: http://localhost:58444/tests/dromaeo/cssquery-dojo.html) 16:12:20 INFO - PID 13476 | RSS: Main: 217632768 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | __start_tp_report 16:12:20 INFO - PID 13476 | _x_x_mozilla_page_load 16:12:20 INFO - PID 13476 | _x_x_mozilla_page_load_details 16:12:20 INFO - PID 13476 | |i|pagename|runs| 16:12:20 INFO - PID 13476 | |0;dojo.html;3165.0663054398938;3239.8704051837926;3291.637919828818;3308.454105072663;3321.950170747439;6258.561900666955;6270.8118756437325;6429;6446.290908000116;6463.159789227394;6247.062940558907;6336.778212762554;6338.176037115169;6363.918133917234;6370.426661600455;5754.769809207627;5814.127880817869;5833.125031245326;5839.270091238595;5840.591158618899;5784.392638772932;5864.4135586441225;5887.440693134166;5898.410158984088;5909.084091965752;5891.175235467038;5911.201987731644;5918.496927761145;5922.703864806764;5926.081457374093;5841.883162336772;5850.151727999438;5863.5309175265875;5905.940940590582;5932.139839723259;5852.297724273072;5883.058710606325;5904.586678932476;5982.282126144847;6010;6191.81424557264;6238.656873871935;6362.618242905441;6451.419372256472;6473.482121430321;6616.139901812733;6675.132232809752;6694.6652667366925;6710.865782684319;6732.461403087741;6685.264620891747;6729.93270067298;6764.8308792280095;6770.289119642465;6773.72905083796;6345.111684364193;6363.331850155713;6366.172397588331;6457.4188323050685;6469.870602587922;6862.656867156722;6993.125859267591;7099.751508697171;7170.892436613507;7199.89200161998;6692.86614267712;6705.932940670628;6741.1236539249585;6818.761343352959;6826.283240259701;6738.460923126138;6845.281245469154;6864.176298844171;6876.140482439695;6891.965540172267;6409.455196308366;6761.256261811197;6843.418309443654;6862.382385585322;6866.519343645897;6690.83272918181;6771;6892.414144797648;6895.862082758316;6898.8620227596175;5210.426853046162;5318.840434786963;5340.732963351817;5378.623496355296;5476.479734425223;4687.039156972813;4710.599599034052;4768.928466073012;4775.6657034007285;4795.040991801654;5917.289925209003;5950.940490595125;5973.044312909914;5991.071383935497;5999.400059993965;6810.080639113657;6849.1780986281965;6849.280825513349;6950.957356396581;6966.616836073963;5702.116171993348;5848.678322692208;5869.911951320733;5927.110933359944;5997.0404735242155;5904.143899134601;6026.337102918676;6035.245594300713;6051.969740151271;6057.394260573996;6674.199096108498;6698;6723.260441351447;6730.596164230162;6822.590644561342;6685.33146685347;6841.350071743176;6911.2397636259975;6916.654167291515;7039.049728286615;6527.314631963765;6545.2800191979795;6545.607263564011;6556.147700798866;6559.573627714183;6675.065490831191;6684.7326106957125;6697.53117281805;6700.966495167493;6703.564268322543;6687.898089172152;6740.292269311652;6769.593824370553;6782.898256526255;6790.626515541692;6466.967665161644;6511.967440162769;6517.837054073686;6530.542861999615;6535.477161826947;6504.38208370204;6553;6556.737730490918;6556.770513032021;6691.698873550605;6593.274739778524;6598.1422415085735;6657.73369065232;6677.76627818024;6735.865282694221;6679.866402672016;6710.966445167743;6717.596944183365;6743.224529179011;6839.726410943506;6373.776917807854;6459.4832413405875;6489.221293444817;6586.1438013058;6628.602283862983 16:12:20 INFO - PID 13476 | |1;ext.html;807.5598798654732;816.7182322098873;833.366641352572;864.5677161419294;864.85729854574;38933;39433.21133577327;39521.80239098801;39559.40660890082;39750.60249397505;35041.824790876075;35157.12107197321;35462.8226858866;35666.2866742665;35772.46341304883;6853.897191542118;6979.825504362406;7013.8597228055405;7016.087908571879;7020.648967551628;6832.180138383376;6888.483363747714;6973.825654358656;6992.6154061526595;7011.368976792088;6903.447724182053;6938.444924406035;6954.582725036514;7559.130699969492;7750.14748377678;7564.621768911533;7663.310302072785;7671.731489397845;7716.112647045606;7752.961235193788;7521.548707077538;7562.168161502231;7575.469717119804;7601.581912994783;7616.238376162395;35942.82028589866;36329.27341453156;36690.63309366899;36855.07862303437;37324.62675373239;3482.547268855058;3518.630543792916;3520.964790352115;3524.8766293179615;3527.4356103023392;31086.911958081586;31096.533551996738;31237.53143702846;31301.843490782627;31404.528932066038;5136.049830781318;5156.1750119981;5178.741062946838;5215.6609820361555;5280.1815718563685;184944;186444;187777;188150;188392;45845;46184.76907615441;46411.53588464072;46417.303740443924;46537.7673111639;47860.28209576859;47894.76052619715;47903;48143.277850832266;48236.27645585319;14734.705305894036;15038.54884353471;15048.32282547288;15055.322510487054;15090.24548772557;12257.325847078318;12369.072319576067;12376.81434778479;12397;12402.937985310016;13515.25666088355;13563.118397304144;13636.454541818415;13636.909047276195;13850.515231966832;5567.3040869891265;5589.608727389125;5597.188407680864;5602.299712535933;5784.681842498619;988.6935050134481;991.9752006199902;996.5117092624562;1010.7271036820165;1014.3862962907482;22389.216377427038;22720;22835.173186145068;22893.25772526272;23269.88365058164;1082.4953314892307;1105.5798796457455;1107.213878146525;1116.7319843237726;1118.697951553076;11872.703182420508;12006.699832504082;12042.337671428155;12054.337011464278;12099.75800484003;218796;219479;223102;224096;224480;42382.78808605937;43337.78331108324;48854.75572622114;49011;49468.75265623721;1419.8012278281049;1437.4609521429463;1439.2300119436052;1443.3865607116934;1455.9272036398138;26762.464750705265;27392;27658;27828.30429239285;28234.71765282321;36414.4537831938;36511.634883650826;36522.452163218106;36657.26685466329;36915.8154209238;205948;207452;207829;209478;209709;33913.15217119493;34323.828380857936;34503.654963451045;34652.13369665779;34697.653023470455;43619;43710.56289437192;43948.340774887765;44488.55511444844;45054.77472612747;32800;33162.17094572655;33213.667863321054;33249.501257480675;33395.66604334023;32398.83800581076;33002;33339;33479.49780753242;33639.83180084182;36088.45867312045;36145.457818133276;36608.26783464369;36704.63295367012;36745.63254367529;31392;31977.840110799298;32010.19974500656;32369.19077022999;33022.33955320928;23178.249302446384;23993.28020159398;24360.26919192427;24715.752842471346;24926 16:12:20 INFO - PID 13476 | |2;jquery.html;544.3766886914483;551.555997422075;562.6174201542949;575.5654480866946;576.9624974376666;21261.57476850462;21956.560868782613;21962.45093872654;21978.45053873654;22005;24271.150509732164;25375.365615859613;25508.617370739456;25601.23196304114;25685.871570642168;6633.734650613982;6761.4590832733265;6782.1183246177925;6803.251642319341;6806.591604503746;3919.8432062717457;6627.602343859384;6635.303293154222;6663;6689.2976237495095;4060.939085913714;6849.657517124148;7210.7476238331665;7218.602976836272;7222.241664625191;7123.394511466531;7137.4290056795335;7157.999999999974;7204.783856484314;7217.4586905982;6971.477139214579;6993.720251189946;6999.23008469068;7005.614691191982;7015.684294206773;29202.269943251376;29435.70564294351;30053.69946300531;30382.54426183609;30958.690413095806;2103;2140.678898165272;2141.154244073582;2146.377550510366;2151.268568686654;19972.300969466145;20451.079701413473;20457.079431425474;20624.69062964057;20660.896695516578;2511.2717311979504;2538.631898374725;2594.377349436141;2606.569915963864;2609.321576390133;138341;141463.29268353592;141711.29144354316;142322.28838855738;143137;18872.39111217648;20375.453068366452;21526.246581369578;21541.353759387242;23150.07399703993;41104;41438.37842432366;41558.37662435066;41571;41656.1668766629;10850.457477126112;10879.619213327655;11140.164487663458;11229.831552526719;11238.100951923827;9128.90871091294;9176.49529275883;9196.310276729271;9290.767730806649;9293.581788819383;8812.339074569432;10758.946205268923;11159.497822598003;11396.886031139748;11476.713082173012;2791.1626512046305;2846.2742000789667;2860.613817134702;2876.7698584113223;2943.3083225442006;944.2776276148752;981.6564202529057;990.7622170678985;1001.0540039662594;1015.7511409704522;19404.611907761766;19513.90243048804;19553.902230488755;19767.209311627663;20209.292674756314;1043.293186271096;1046.3303485769113;1055.2402270365324;1055.8416237564427;1059.9841002384971;11080.335179889233;11193.440327983568;11196.216264861545;11234.943825280821;11259.324440533594;492555;518753;528766;543987;545366;116980;119475.40262298632;121055.39472302582;123315.38342308231;123616.38191808983;1199.7180662544295;1224.7305592769576;1229.1396022783908;1241.944112514939;1242.2794779028322;20538.17847286092;20707.585848282648;20794.792052079287;20816.791832081486;21232.469188270417;55907;56596.43403565911;56907.715461424086;57256;57691.134632981375;71784.64107679637;74736;77001.61499192468;77947;79380;14333.283335833376;14603.269836508345;14776.187309698069;14786.112833230041;14976.550703478913;23086.422839428476;23189.42026449352;23194.536109277382;23323.416914577272;23389.649155263025;18563.164657590172;18627.72058419152;18657.880527167872;18755.812441875405;18881.622367552845;16664.41674541385;16753.497395078168;17253.741193882353;17263.482095537154;17269.481915542554;17964.101794910464;18697.81302187015;18871.90564047171;19132;19605.31381401644;14360.784588231394;14439.639009024859;14567.198804065878;14567.271636418349;14595.124292542481;18223.179956901706;18385.90807045956;18472.07639617987;18559.814401856347;18676.906615466836 16:12:20 INFO - PID 13476 | |3;mootools.html;1342.5502456677013;1398.1960372785645;1398.7552178368783;1399.251400500732;1405.2552147361903;14654.926725366371;15224.619384515392;15431.45989890354;15467.38130474781;15888.285027173775;15964.76052859208;16165.35338586458;16190.75713864293;16209.108499032549;16228.594285142877;2712.227015300645;2764.04640399062;2768.43247134337;2770.1689493152076;2772.50094982903;2636.6835979682464;2649.668791401075;2727.9590806137926;2782.1792571191445;2805.705400932903;2783.4154827486254;2786.512360336943;2809.761170300527;2819.8026138170235;2820.2667306500357;2650.3639126609573;2676.812623116383;2694.312950197707;2694.932626684329;2699.5545734953707;2717.782577393804;2728.45430913818;2729.686086100104;2731.207949694606;2732.1393760965234;14854.2572871356;15016.24918754058;15153.772693409608;15154.166520841349;15155.545333639899;7748.883766743504;7833.451658383916;7951.165127661628;8018.198180181994;8047.114817370085;5121.871953201163;5243.842684719464;5355.3305836770405;5375.16684913839;5384.91922621161;1866.150901339887;1905.8951757653324;1915.6456055629753;1955.9706604400944;1963.2049020146721;26520.602190967344;26565;26574.734252657418;26794.732052679417;26819.195424137306;6727.66361681914;6784.830379240559;6795.626240556817;6991.545549539263;7050.224475307712;17295.30818767235;17465.03942283161;17472.30110795554;17473.82526174722;17487.213075411637;7912.327452166515;7937;7981.161977992228;7985.121636619967;8058.033036035596;6886.10480637524;7029.332213439715;7043.330883566053;7161.677724502306;7401.111866576045;4640.211164102111;4977.502249775066;4978.975105124451;5047.646664733434;5235.712035837989;1343.2209318595192;1349.1432940083118;1368.9589312320647;1374.305975482375;1376.9655758605916;862.185234952976;872.9345299102592;879.2087121590491;879.6041781198486;892.7009451833578;8381.874271885927;8393.874091888627;8452.957735211285;8503.362247831314;8539.530325832138;980.7401038724744;988.619381538113;998.0967224661692;999.0459111548454;1011.0647650922867;4931.457539670633;4980.402351717745;4993.7503124843615;5023.924641130386;5324.254604355393;21184.470388240108;21229.15083396647;21865.453363666034;22018.889905550368;22036.11855525761;19704.70442943357;20422.897885510476;20427.28504502365;21880.45298867541;22162.556748864932;10892.727681808019;10970.434713312297;11066.833997490045;11213.66359009231;11221.382823944761;8752.256058234867;8768.693095741874;8959.776005599912;8968.865467018131;9035.27717782589;18701.25194992185;18723.90638046801;18891.811081889005;19072.237110515423;19217.23131074797;18782.436526904214;19012.334568290044;19103.426897193105;19143.138558765168;19901.203951841766;11656.417179141179;11719.41402929833;11779.528818847493;11794.823077653671;11895.286282823059;12137.878621213675;12654.30401327899;14246.928765356108;14438.783418248524;14452;10650.73373165646;11528.884711152781;11666.358350290815;11763.529458821893;11804.704882377666;11026.834597481205;11089;11299.887001129884;11411.885881141083;11454.713632159262;9944.552495137592;10005.899941000496;10108.747281318027;10130.189584833048;10148.695539133838;7001.404880585207;7094.290570942864;7129.287071292829;7131.643417829192;7323.963380183065;7371.336579707852;7415.888761668687;7417.629118544159;7441.702331906879;7479 16:12:20 INFO - PID 13476 | |4;prototype.html;486.85249859657307;504.27888119988427;525.7003508000437;530.3503208569502;530.3979982719613;6366.490680745541;6379.553431259814;6385.33981164897;6446.32313607071;6473.126127972722;6149.385061493859;6205.875882482348;6215.5338349623735;6274.4039316265;6289.874202515947;5042;5051.469595692454;5052.747362631872;5065.290859279695;5082.720450375228;5044.47033061527;5067.518585734368;5068.113080210948;5077.720725360104;5085.66943148696;4835.734034628094;4937.481564435737;4973.254011898208;4998.775055122528;5031.597472202233;4951.579115775164;5038.697678139323;5058.317127187837;5059.772310246048;5073.467285934979;4468.039371535103;4498.4358915418225;4513.729176249402;4538.273876179828;4546.136234115507;6158.384161583851;6216.658083805389;6229.4704950079295;6267.62394256346;6274.2784579773;5728.9115068137335;5750.281214848144;5751.19483272338;5753.683547404891;5770.307563092456;6571.704273307712;6665.366790154928;6674.299198584127;6702.262751097375;6711.295313992009;4821.517848215186;4853.951460485385;4861.975690121527;4868.075065737498;4896.730679812609;6822.692978815965;6923.584584924921;6939.826504337331;6967.268436814113;6983.406410455117;5056.165732654071;5060.367454068241;5078.5937125029905;5083.6187285952965;5107.795688172431;5106.080905436983;5135.460776618476;5170.689758614495;5188;5189.377274727057;5665.575081868877;5679.466544033171;5719.342275638355;5727.885442291131;5736.885262294731;6559.606423614503;6610.305917878553;6705.832354191087;6725.39471447572;6727.360900714424;1691.365737848307;1765.4791836408033;1768.8054314025446;1790.1228398084845;1796.4281253902834;1114.3648120571197;1153.382940127028;1179.7876382251106;1214.5688280660415;1235.7034311765112;5743.10981797822;5771.422857714195;5799.159121927297;5847.1229315603;5884.293884733774;6692.783546365758;6718.49611279156;6777.661116944231;6778.389944904884;6789.15135608049;5621.550275977912;5684.403137670568;5756.416985329068;5807.925533776181;5855.443732845373;3489.337025965109;3494.2312691207894;3550.396432606463;3566.91082722934;3567.375709250871;6432.807015789534;6451.161349024596;6480.569786330127;6521.250056243498;6559.508036897252;6734.595924244561;6844.486663500158;6867.141607299088;6899.861043076662;6904.965475172692;6420;6440.227172739301;6458.22501299847;6528.804135875931;6553.2136143663065;6575;6630.701618427086;6671.733130674718;6696.966515167393;6779.593224406552;6532.673366331759;6544.411003009752;6620;6633;6749.932500675127;6520.413162815369;6580.967095164494;6591.177117272066;6615.867682646416;6638.834029149117;4981.900361992813;5009.774560144875;5053.043969277866;5062.165187495015;5065.113605119163;6722.294159113223;6722.630255336004;6732.394084532416;6805.761798337233;6809.21694005176;6491.642959637265;6534.313897040933;6544.738210471528;6544.869102617826;6559.573627714183;6340.682965851597;6361.650109243851;6363.600007998233;6401.135846660642;6554.311797261219;6068.726907289094;6463;6534.4772418205475;6550.705218265285;6595.934040659532;6617.966910165418;6661.16735408074;6689.49828762835;6699.698513566804;6701.731930722716;6398.168238129014;6407.327230640715;6429.421352078335;6506.154199953976;6521.445677117498 16:12:20 INFO - PID 13476 | |5;yui.html;883.845327067763;898.3217670658654;921.2998121427713;921.6129225725199;925.5326060339528;18592;19334.129964151613;19339.22643094278;19361.322353717624;19396.90301548492;19791.307304244354;21249.25627603034;21387.786122138776;21395.786042139574;21564.784352156476;963.1283688262116;974.9463779492125;980.3382716666257;983.54265266651;984.8424252119662;938.3947353956694;991.6380521109779;994.9253805964545;995.8904520502739;996.9850452243222;1033.4264483211814;1050.5955207245227;1052.1582733812918;1054.8259537176357;1056.8520407142967;1038.4755698372273;1039.5789705169418;1040.1107053469289;1042.9582816687323;1043.1237760281363;766.4022062791032;767.8656235158825;768.7616838779941;769.2384539306047;770.0336078221852;19116.5220869478;19294.13176407065;19457.902710486498;19573.119209635457;19817.50456238591;20437.489062773402;20512.487187820276;20968.685469717966;21016.474588135265;21041.684374734392;16374.426895058736;16405.753913691304;16610.418635347705;16761.7485737714;16762.664746705;3664.395374763161;3695.7412981091334;3696.149885526317;3696.8706095286807;3698.519192504984;121782;127643;128255;130065.34967325197;132196;16313.10277934725;16619.83380166207;16670.66658666844;16695;16712.74930876038;28880.277993050342;30574.23564410863;30934.0719778407;30935.226619334248;30947.845260774004;8006.079300880357;8049.315808156372;8082.797930051795;8091.959540202379;8111.756647300473;4012.6990475714438;4089.509258888893;4091.263572556909;4093.7953102344763;4098.959010409858;4778.283257511401;5525.640833345819;5575.944240557543;5733.397993210736;5833.79581714638;1064.3720205078885;1093.1091160704;1111.5887121764838;1111.7554138089608;1120.288616728367;664.7307840324676;664.7440735316937;668.4719071933216;673.6699017481399;683.1528904158906;11942.820857687142;12807.743845123045;13483.730325393437;13485.325733713471;13592.048556601141;678.0947435173999;682.1984168601873;683.1051322767191;687.848673291875;702.0978043214445;5733.799317023884;5804.952399990039;5839.678817664984;5943.3462319144855;6001.969990150109;99585.50207248918;103539;104282;104851.4757426208;110129;90763.80282253191;91154;92774.53612732029;94580;99379;82804;84093;84598.57700711457;86129.70805437924;86595;12358.691032723895;12469.688257793629;12856.871431285568;13374;13403.664908377368;38629.4205586922;39320.80339598398;40229.79885100556;40545;40571.59428405678;67966.66016669886;69000;69262.65368673124;70699.29300706927;71190.64404677943;18775.155118019447;19170.904145479184;19233.80766192376;19253.90373048126;19490.415287541397;21046.894765526074;21179.47051323729;21479.140834367074;21592.24427145105;21607.891960540095;17327.2202750874;17467.82532174662;17489.56276093108;18515.166817493515;18930.43208703741;18051.729224061914;18162.818371816113;18866.434006979813;19374.2250309986;19597.608047839247;17522.211500482255;17648.823511765233;18015.099245037956;18791.34230301933;19461.221551138362;12816.423260953094;12886.742265154457;12914.483420663444;12928.547500837425;13465.39405726725;14445.85554144445;14812.111273323635;14929.477468288558;14977.1013739176;15272.465463708717 16:12:20 INFO - PID 13476 | __end_tp_report 16:12:20 INFO - PID 13476 | __start_cc_report 16:12:20 INFO - PID 13476 | _x_x_mozilla_cycle_collect,379 16:12:20 INFO - PID 13476 | __end_cc_report 16:12:20 INFO - PID 13476 | __startTimestamp1504653140893__endTimestamp 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | ------- Summary: start ------- 16:12:20 INFO - PID 13476 | Number of tests: 6 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | [#0] dojo.html Cycles:165 Average:6278.98 Median:6517.84 stddev:733.36 (11.3%) stddev-sans-first:693.74 16:12:20 INFO - PID 13476 | Values: 3165.1 3239.9 3291.6 3308.5 3322.0 6258.6 6270.8 6429.0 6446.3 6463.2 6247.1 6336.8 6338.2 6363.9 6370.4 5754.8 5814.1 5833.1 5839.3 5840.6 5784.4 5864.4 5887.4 5898.4 5909.1 5891.2 5911.2 5918.5 5922.7 5926.1 5841.9 5850.2 5863.5 5905.9 5932.1 5852.3 5883.1 5904.6 5982.3 6010.0 6191.8 6238.7 6362.6 6451.4 6473.5 6616.1 6675.1 6694.7 6710.9 6732.5 6685.3 6729.9 6764.8 6770.3 6773.7 6345.1 6363.3 6366.2 6457.4 6469.9 6862.7 6993.1 7099.8 7170.9 7199.9 6692.9 6705.9 6741.1 6818.8 6826.3 6738.5 6845.3 6864.2 6876.1 6892.0 6409.5 6761.3 6843.4 6862.4 6866.5 6690.8 6771.0 6892.4 6895.9 6898.9 5210.4 5318.8 5340.7 5378.6 5476.5 4687.0 4710.6 4768.9 4775.7 4795.0 5917.3 5950.9 5973.0 5991.1 5999.4 6810.1 6849.2 6849.3 6951.0 6966.6 5702.1 5848.7 5869.9 5927.1 5997.0 5904.1 6026.3 6035.2 6052.0 6057.4 6674.2 6698.0 6723.3 6730.6 6822.6 6685.3 6841.4 6911.2 6916.7 7039.0 6527.3 6545.3 6545.6 6556.1 6559.6 6675.1 6684.7 6697.5 6701.0 6703.6 6687.9 6740.3 6769.6 6782.9 6790.6 6467.0 6512.0 6517.8 6530.5 6535.5 6504.4 6553.0 6556.7 6556.8 6691.7 6593.3 6598.1 6657.7 6677.8 6735.9 6679.9 6711.0 6717.6 6743.2 6839.7 6373.8 6459.5 6489.2 6586.1 6628.6 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | [#1] ext.html Cycles:180 Average:37047.49 Median:3519.80 stddev:53354.73 (1515.8%) stddev-sans-first:53435.01 16:12:20 INFO - PID 13476 | Values: 807.6 816.7 833.4 864.6 864.9 38933.0 39433.2 39521.8 39559.4 39750.6 35041.8 35157.1 35462.8 35666.3 35772.5 6853.9 6979.8 7013.9 7016.1 7020.6 6832.2 6888.5 6973.8 6992.6 7011.4 6903.4 6938.4 6954.6 7559.1 7750.1 7564.6 7663.3 7671.7 7716.1 7753.0 7521.5 7562.2 7575.5 7601.6 7616.2 35942.8 36329.3 36690.6 36855.1 37324.6 3482.5 3518.6 3521.0 3524.9 3527.4 31086.9 31096.5 31237.5 31301.8 31404.5 5136.0 5156.2 5178.7 5215.7 5280.2 184944.0 186444.0 187777.0 188150.0 188392.0 45845.0 46184.8 46411.5 46417.3 46537.8 47860.3 47894.8 47903.0 48143.3 48236.3 14734.7 15038.5 15048.3 15055.3 15090.2 12257.3 12369.1 12376.8 12397.0 12402.9 13515.3 13563.1 13636.5 13636.9 13850.5 5567.3 5589.6 5597.2 5602.3 5784.7 988.7 992.0 996.5 1010.7 1014.4 22389.2 22720.0 22835.2 22893.3 23269.9 1082.5 1105.6 1107.2 1116.7 1118.7 11872.7 12006.7 12042.3 12054.3 12099.8 218796.0 219479.0 223102.0 224096.0 224480.0 42382.8 43337.8 48854.8 49011.0 49468.8 1419.8 1437.5 1439.2 1443.4 1455.9 26762.5 27392.0 27658.0 27828.3 28234.7 36414.5 36511.6 36522.5 36657.3 36915.8 205948.0 207452.0 207829.0 209478.0 209709.0 33913.2 34323.8 34503.7 34652.1 34697.7 43619.0 43710.6 43948.3 44488.6 45054.8 32800.0 33162.2 33213.7 33249.5 33395.7 32398.8 33002.0 33339.0 33479.5 33639.8 36088.5 36145.5 36608.3 36704.6 36745.6 31392.0 31977.8 32010.2 32369.2 33022.3 23178.2 23993.3 24360.3 24715.8 24926.0 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | [#2] jquery.html Cycles:180 Average:37068.70 Median:21748.96 stddev:88366.43 (406.3%) stddev-sans-first:88571.77 16:12:20 INFO - PID 13476 | Values: 544.4 551.6 562.6 575.6 577.0 21261.6 21956.6 21962.5 21978.5 22005.0 24271.2 25375.4 25508.6 25601.2 25685.9 6633.7 6761.5 6782.1 6803.3 6806.6 3919.8 6627.6 6635.3 6663.0 6689.3 4060.9 6849.7 7210.7 7218.6 7222.2 7123.4 7137.4 7158.0 7204.8 7217.5 6971.5 6993.7 6999.2 7005.6 7015.7 29202.3 29435.7 30053.7 30382.5 30958.7 2103.0 2140.7 2141.2 2146.4 2151.3 19972.3 20451.1 20457.1 20624.7 20660.9 2511.3 2538.6 2594.4 2606.6 2609.3 138341.0 141463.3 141711.3 142322.3 143137.0 18872.4 20375.5 21526.2 21541.4 23150.1 41104.0 41438.4 41558.4 41571.0 41656.2 10850.5 10879.6 11140.2 11229.8 11238.1 9128.9 9176.5 9196.3 9290.8 9293.6 8812.3 10758.9 11159.5 11396.9 11476.7 2791.2 2846.3 2860.6 2876.8 2943.3 944.3 981.7 990.8 1001.1 1015.8 19404.6 19513.9 19553.9 19767.2 20209.3 1043.3 1046.3 1055.2 1055.8 1060.0 11080.3 11193.4 11196.2 11234.9 11259.3 492555.0 518753.0 528766.0 543987.0 545366.0 116980.0 119475.4 121055.4 123315.4 123616.4 1199.7 1224.7 1229.1 1241.9 1242.3 20538.2 20707.6 20794.8 20816.8 21232.5 55907.0 56596.4 56907.7 57256.0 57691.1 71784.6 74736.0 77001.6 77947.0 79380.0 14333.3 14603.3 14776.2 14786.1 14976.6 23086.4 23189.4 23194.5 23323.4 23389.6 18563.2 18627.7 18657.9 18755.8 18881.6 16664.4 16753.5 17253.7 17263.5 17269.5 17964.1 18697.8 18871.9 19132.0 19605.3 14360.8 14439.6 14567.2 14567.3 14595.1 18223.2 18385.9 18472.1 18559.8 18676.9 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | [#3] mootools.html Cycles:180 Average:9386.65 Median:14625.77 stddev:6712.61 (45.9%) stddev-sans-first:6704.23 16:12:20 INFO - PID 13476 | Values: 1342.6 1398.2 1398.8 1399.3 1405.3 14654.9 15224.6 15431.5 15467.4 15888.3 15964.8 16165.4 16190.8 16209.1 16228.6 2712.2 2764.0 2768.4 2770.2 2772.5 2636.7 2649.7 2728.0 2782.2 2805.7 2783.4 2786.5 2809.8 2819.8 2820.3 2650.4 2676.8 2694.3 2694.9 2699.6 2717.8 2728.5 2729.7 2731.2 2732.1 14854.3 15016.2 15153.8 15154.2 15155.5 7748.9 7833.5 7951.2 8018.2 8047.1 5121.9 5243.8 5355.3 5375.2 5384.9 1866.2 1905.9 1915.6 1956.0 1963.2 26520.6 26565.0 26574.7 26794.7 26819.2 6727.7 6784.8 6795.6 6991.5 7050.2 17295.3 17465.0 17472.3 17473.8 17487.2 7912.3 7937.0 7981.2 7985.1 8058.0 6886.1 7029.3 7043.3 7161.7 7401.1 4640.2 4977.5 4979.0 5047.6 5235.7 1343.2 1349.1 1369.0 1374.3 1377.0 862.2 872.9 879.2 879.6 892.7 8381.9 8393.9 8453.0 8503.4 8539.5 980.7 988.6 998.1 999.0 1011.1 4931.5 4980.4 4993.8 5023.9 5324.3 21184.5 21229.2 21865.5 22018.9 22036.1 19704.7 20422.9 20427.3 21880.5 22162.6 10892.7 10970.4 11066.8 11213.7 11221.4 8752.3 8768.7 8959.8 8968.9 9035.3 18701.3 18723.9 18891.8 19072.2 19217.2 18782.4 19012.3 19103.4 19143.1 19901.2 11656.4 11719.4 11779.5 11794.8 11895.3 12137.9 12654.3 14246.9 14438.8 14452.0 10650.7 11528.9 11666.4 11763.5 11804.7 11026.8 11089.0 11299.9 11411.9 11454.7 9944.6 10005.9 10108.7 10130.2 10148.7 7001.4 7094.3 7129.3 7131.6 7324.0 7371.3 7415.9 7417.6 7441.7 7479.0 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | [#4] prototype.html Cycles:180 Average:5544.52 Median:6223.06 stddev:1557.63 (25.0%) stddev-sans-first:1515.03 16:12:20 INFO - PID 13476 | Values: 486.9 504.3 525.7 530.4 530.4 6366.5 6379.6 6385.3 6446.3 6473.1 6149.4 6205.9 6215.5 6274.4 6289.9 5042.0 5051.5 5052.7 5065.3 5082.7 5044.5 5067.5 5068.1 5077.7 5085.7 4835.7 4937.5 4973.3 4998.8 5031.6 4951.6 5038.7 5058.3 5059.8 5073.5 4468.0 4498.4 4513.7 4538.3 4546.1 6158.4 6216.7 6229.5 6267.6 6274.3 5728.9 5750.3 5751.2 5753.7 5770.3 6571.7 6665.4 6674.3 6702.3 6711.3 4821.5 4854.0 4862.0 4868.1 4896.7 6822.7 6923.6 6939.8 6967.3 6983.4 5056.2 5060.4 5078.6 5083.6 5107.8 5106.1 5135.5 5170.7 5188.0 5189.4 5665.6 5679.5 5719.3 5727.9 5736.9 6559.6 6610.3 6705.8 6725.4 6727.4 1691.4 1765.5 1768.8 1790.1 1796.4 1114.4 1153.4 1179.8 1214.6 1235.7 5743.1 5771.4 5799.2 5847.1 5884.3 6692.8 6718.5 6777.7 6778.4 6789.2 5621.6 5684.4 5756.4 5807.9 5855.4 3489.3 3494.2 3550.4 3566.9 3567.4 6432.8 6451.2 6480.6 6521.3 6559.5 6734.6 6844.5 6867.1 6899.9 6905.0 6420.0 6440.2 6458.2 6528.8 6553.2 6575.0 6630.7 6671.7 6697.0 6779.6 6532.7 6544.4 6620.0 6633.0 6749.9 6520.4 6581.0 6591.2 6615.9 6638.8 4981.9 5009.8 5053.0 5062.2 5065.1 6722.3 6722.6 6732.4 6805.8 6809.2 6491.6 6534.3 6544.7 6544.9 6559.6 6340.7 6361.7 6363.6 6401.1 6554.3 6068.7 6463.0 6534.5 6550.7 6595.9 6618.0 6661.2 6689.5 6699.7 6701.7 6398.2 6407.3 6429.4 6506.2 6521.4 16:12:20 INFO - PID 13476 | 16:12:20 INFO - PID 13476 | [#5] yui.html Cycles:180 Average:23597.93 Median:21113.18 stddev:31509.10 (149.2%) stddev-sans-first:31551.33 16:12:20 INFO - PID 13476 | Values: 883.8 898.3 921.3 921.6 925.5 18592.0 19334.1 19339.2 19361.3 19396.9 19791.3 21249.3 21387.8 21395.8 21564.8 963.1 974.9 980.3 983.5 984.8 938.4 991.6 994.9 995.9 997.0 1033.4 1050.6 1052.2 1054.8 1056.9 1038.5 1039.6 1040.1 1043.0 1043.1 766.4 767.9 768.8 769.2 770.0 19116.5 19294.1 19457.9 19573.1 19817.5 20437.5 20512.5 20968.7 21016.5 21041.7 16374.4 16405.8 16610.4 16761.7 16762.7 3664.4 3695.7 3696.1 3696.9 3698.5 121782.0 127643.0 128255.0 130065.3 132196.0 16313.1 16619.8 16670.7 16695.0 16712.7 28880.3 30574.2 30934.1 30935.2 30947.8 8006.1 8049.3 8082.8 8092.0 8111.8 4012.7 4089.5 4091.3 4093.8 4099.0 4778.3 5525.6 5575.9 5733.4 5833.8 1064.4 1093.1 1111.6 1111.8 1120.3 664.7 664.7 668.5 673.7 683.2 11942.8 12807.7 13483.7 13485.3 13592.0 678.1 682.2 683.1 687.8 702.1 5733.8 5805.0 5839.7 5943.3 6002.0 99585.5 103539.0 104282.0 104851.5 110129.0 90763.8 91154.0 92774.5 94580.0 99379.0 82804.0 84093.0 84598.6 86129.7 86595.0 12358.7 12469.7 12856.9 13374.0 13403.7 38629.4 39320.8 40229.8 40545.0 40571.6 67966.7 69000.0 69262.7 70699.3 71190.6 18775.2 19170.9 19233.8 19253.9 19490.4 21046.9 21179.5 21479.1 21592.2 21607.9 17327.2 17467.8 17489.6 18515.2 18930.4 18051.7 18162.8 18866.4 19374.2 19597.6 17522.2 17648.8 18015.1 18791.3 19461.2 12816.4 12886.7 12914.5 12928.5 13465.4 14445.9 14812.1 14929.5 14977.1 15272.5 16:12:20 INFO - PID 13476 | -------- Summary: end -------- 16:12:20 INFO - PID 13476 | 16:12:21 INFO - TEST-INFO | 13476: exit 0 16:12:21 INFO - TEST-OK | dromaeo_css | took 1114331ms 16:12:21 INFO - TEST-START | kraken 16:12:21 INFO - Initialising browser for kraken test... 16:12:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58444/getInfo.html -profile /tmp/tmpysQh0p/profile 16:12:21 INFO - TEST-INFO | started process 13863 (/builds/slave/test/build/application/firefox/firefox http://localhost:58444/getInfo.html) 16:12:28 INFO - TEST-INFO | 13863: exit 0 16:12:29 INFO - Browser initialized. 16:12:29 INFO - Running cycle 1/1 for kraken test... 16:12:29 INFO - Using env: {'DISPLAY': ':0', 16:12:29 INFO - 'HOME': '/home/cltbld', 16:12:29 INFO - 'JSGC_DISABLE_POISONING': '1', 16:12:29 INFO - 'LANG': 'en_US.UTF-8', 16:12:29 INFO - 'LANGUAGE': 'en_US:en', 16:12:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:12:29 INFO - 'LOGNAME': 'cltbld', 16:12:29 INFO - 'MAIL': '/var/mail/cltbld', 16:12:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:29 INFO - 'MOZ_ACCELERATED': '1', 16:12:29 INFO - 'MOZ_CRASHREPORTER': '1', 16:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:12:29 INFO - 'MOZ_NO_REMOTE': '1', 16:12:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:29 INFO - 'MOZ_WEBRENDER': '1', 16:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:29 INFO - 'NO_EM_RESTART': '1', 16:12:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:29 INFO - 'PWD': '/builds/slave/test', 16:12:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:29 INFO - 'RUST_BACKTRACE': 'full', 16:12:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:12:29 INFO - 'SHELL': '/bin/bash', 16:12:29 INFO - 'SHLVL': '1', 16:12:29 INFO - 'TERM': 'linux', 16:12:29 INFO - 'TMOUT': '86400', 16:12:29 INFO - 'USER': 'cltbld', 16:12:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670', 16:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:29 INFO - '_': '/tools/buildbot/bin/python'} 16:12:29 INFO - TEST-INFO | started process 14056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpysQh0p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:30 INFO - PID 14056 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:12:30 INFO - PID 14056 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:12:30 INFO - PID 14056 | 16:12:30 INFO - PID 14056 | (/builds/slave/test/build/application/firefox/firefox:14118): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:12:30 INFO - PID 14056 | 16:12:40 INFO - PID 14056 | RSS: Main: 203776000 16:12:40 INFO - PID 14056 | 16:12:43 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58444/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:44 INFO - PID 14056 | RSS: Main: 210452480 16:12:44 INFO - PID 14056 | 16:12:47 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58444/tests/kraken/driver.html?testName=audio-dft) 16:12:47 INFO - PID 14056 | RSS: Main: 209707008 16:12:47 INFO - PID 14056 | 16:12:50 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58444/tests/kraken/driver.html?testName=audio-fft) 16:12:51 INFO - PID 14056 | RSS: Main: 204386304 16:12:51 INFO - PID 14056 | 16:12:53 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58444/tests/kraken/driver.html?testName=audio-oscillator) 16:12:54 INFO - PID 14056 | RSS: Main: 206073856 16:12:54 INFO - PID 14056 | 16:12:56 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:57 INFO - PID 14056 | RSS: Main: 206450688 16:12:57 INFO - PID 14056 | 16:13:00 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58444/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:00 INFO - PID 14056 | RSS: Main: 210362368 16:13:00 INFO - PID 14056 | 16:13:04 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58444/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:05 INFO - PID 14056 | RSS: Main: 210096128 16:13:05 INFO - PID 14056 | 16:13:07 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58444/tests/kraken/driver.html?testName=json-parse-financial) 16:13:08 INFO - PID 14056 | RSS: Main: 210247680 16:13:08 INFO - PID 14056 | 16:13:10 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:10 INFO - PID 14056 | RSS: Main: 210579456 16:13:10 INFO - PID 14056 | 16:13:12 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:13 INFO - PID 14056 | RSS: Main: 206823424 16:13:13 INFO - PID 14056 | 16:13:15 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:15 INFO - PID 14056 | RSS: Main: 207273984 16:13:15 INFO - PID 14056 | 16:13:18 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:19 INFO - PID 14056 | RSS: Main: 207237120 16:13:19 INFO - PID 14056 | 16:13:22 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:23 INFO - PID 14056 | RSS: Main: 207761408 16:13:23 INFO - PID 14056 | 16:13:24 INFO - PID 14056 | Cycle 1(1): loaded http://localhost:58444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58444/tests/kraken/driver.html?testName=ai-astar) 16:13:25 INFO - PID 14056 | RSS: Main: 209760256 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | __start_tp_report 16:13:25 INFO - PID 14056 | _x_x_mozilla_page_load 16:13:25 INFO - PID 14056 | _x_x_mozilla_page_load_details 16:13:25 INFO - PID 14056 | |i|pagename|runs| 16:13:25 INFO - PID 14056 | |0;ai-astar;103;117;102;119;113;109;118;102;111;113 16:13:25 INFO - PID 14056 | |1;audio-beat-detection;143;119;149;181;119;152;148;116;171;120 16:13:25 INFO - PID 14056 | |2;audio-dft;163;162;161;167;163;173;170;162;166;168 16:13:25 INFO - PID 14056 | |3;audio-fft;75;76;74;170;80;74;74;74;157;77 16:13:25 INFO - PID 14056 | |4;audio-oscillator;80;82;135;80;82;80;127;79;82;137 16:13:25 INFO - PID 14056 | |5;imaging-gaussian-blur;115;124;117;117;114;115;114;118;116;116 16:13:25 INFO - PID 14056 | |6;imaging-darkroom;149;161;154;150;148;148;149;149;150;148 16:13:25 INFO - PID 14056 | |7;imaging-desaturate;95;95;95;101;94;102;94;95;95;100 16:13:25 INFO - PID 14056 | |8;json-parse-financial;53;54;55;52;53;63;52;53;53;54 16:13:25 INFO - PID 14056 | |9;json-stringify-tinderbox;45;43;39;42;38;39;46;40;39;42 16:13:25 INFO - PID 14056 | |10;stanford-crypto-aes;75;81;75;80;79;75;79;86;80;76 16:13:25 INFO - PID 14056 | |11;stanford-crypto-ccm;129;122;121;134;126;123;121;119;119;167 16:13:25 INFO - PID 14056 | |12;stanford-crypto-pbkdf2;174;169;178;169;171;179;180;172;179;176 16:13:25 INFO - PID 14056 | |13;stanford-crypto-sha256-iterative;64;72;71;65;63;65;68;69;66;67 16:13:25 INFO - PID 14056 | __end_tp_report 16:13:25 INFO - PID 14056 | __start_cc_report 16:13:25 INFO - PID 14056 | _x_x_mozilla_cycle_collect,957 16:13:25 INFO - PID 14056 | __end_cc_report 16:13:25 INFO - PID 14056 | __startTimestamp1504653205101__endTimestamp 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | ------- Summary: start ------- 16:13:25 INFO - PID 14056 | Number of tests: 14 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:6.55 (5.8%) stddev-sans-first:6.33 16:13:25 INFO - PID 14056 | Values: 103.0 117.0 102.0 119.0 113.0 109.0 118.0 102.0 111.0 113.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:148.50 stddev:23.01 (15.5%) stddev-sans-first:24.40 16:13:25 INFO - PID 14056 | Values: 143.0 119.0 149.0 181.0 119.0 152.0 148.0 116.0 171.0 120.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#2] audio-dft Cycles:10 Average:165.50 Median:166.50 stddev:3.98 (2.4%) stddev-sans-first:4.12 16:13:25 INFO - PID 14056 | Values: 163.0 162.0 161.0 167.0 163.0 173.0 170.0 162.0 166.0 168.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#3] audio-fft Cycles:10 Average:93.10 Median:74.50 stddev:37.28 (50.0%) stddev-sans-first:38.96 16:13:25 INFO - PID 14056 | Values: 75.0 76.0 74.0 170.0 80.0 74.0 74.0 74.0 157.0 77.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:80.00 stddev:25.40 (31.7%) stddev-sans-first:26.24 16:13:25 INFO - PID 14056 | Values: 80.0 82.0 135.0 80.0 82.0 80.0 127.0 79.0 82.0 137.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:116.50 stddev:2.91 (2.5%) stddev-sans-first:3.03 16:13:25 INFO - PID 14056 | Values: 115.0 124.0 117.0 117.0 114.0 115.0 114.0 118.0 116.0 116.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:149.50 stddev:4.06 (2.7%) stddev-sans-first:4.27 16:13:25 INFO - PID 14056 | Values: 149.0 161.0 154.0 150.0 148.0 148.0 149.0 149.0 150.0 148.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:95.00 stddev:3.10 (3.3%) stddev-sans-first:3.23 16:13:25 INFO - PID 14056 | Values: 95.0 95.0 95.0 101.0 94.0 102.0 94.0 95.0 95.0 100.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:3.22 (6.0%) stddev-sans-first:3.39 16:13:25 INFO - PID 14056 | Values: 53.0 54.0 55.0 52.0 53.0 63.0 52.0 53.0 53.0 54.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#9] json-stringify-tinderbox Cycles:10 Average:41.30 Median:42.00 stddev:2.75 (6.5%) stddev-sans-first:2.57 16:13:25 INFO - PID 14056 | Values: 45.0 43.0 39.0 42.0 38.0 39.0 46.0 40.0 39.0 42.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.50 stddev:3.50 (4.4%) stddev-sans-first:3.46 16:13:25 INFO - PID 14056 | Values: 75.0 81.0 75.0 80.0 79.0 75.0 79.0 86.0 80.0 76.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:124.50 stddev:14.46 (11.6%) stddev-sans-first:15.34 16:13:25 INFO - PID 14056 | Values: 129.0 122.0 121.0 134.0 126.0 123.0 121.0 119.0 119.0 167.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:177.00 stddev:4.27 (2.4%) stddev-sans-first:4.52 16:13:25 INFO - PID 14056 | Values: 174.0 169.0 178.0 169.0 171.0 179.0 180.0 172.0 179.0 176.0 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:2.98 (4.4%) stddev-sans-first:2.96 16:13:25 INFO - PID 14056 | Values: 64.0 72.0 71.0 65.0 63.0 65.0 68.0 69.0 66.0 67.0 16:13:25 INFO - PID 14056 | -------- Summary: end -------- 16:13:25 INFO - PID 14056 | 16:13:25 INFO - PID 14056 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:13:25 INFO - TEST-INFO | 14056: exit 0 16:13:25 INFO - TEST-OK | kraken | took 64042ms 16:13:25 INFO - SUITE-END | took 1178s 16:13:26 INFO - Completed test suite (00:19:38) 16:13:26 INFO - javascript benchmark 16:13:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8634.690337321084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.0663054398938, 3239.8704051837926, 3291.637919828818, 3308.454105072663, 3321.950170747439, 6258.561900666955, 6270.8118756437325, 6429.0, 6446.290908000116, 6463.159789227394, 6247.062940558907, 6336.778212762554, 6338.176037115169, 6363.918133917234, 6370.426661600455, 5754.769809207627, 5814.127880817869, 5833.125031245326, 5839.270091238595, 5840.591158618899, 5784.392638772932, 5864.4135586441225, 5887.440693134166, 5898.410158984088, 5909.084091965752, 5891.175235467038, 5911.201987731644, 5918.496927761145, 5922.703864806764, 5926.081457374093, 5841.883162336772, 5850.151727999438, 5863.5309175265875, 5905.940940590582, 5932.139839723259, 5852.297724273072, 5883.058710606325, 5904.586678932476, 5982.282126144847, 6010.0, 6191.81424557264, 6238.656873871935, 6362.618242905441, 6451.419372256472, 6473.482121430321, 6616.139901812733, 6675.132232809752, 6694.6652667366925, 6710.865782684319, 6732.461403087741, 6685.264620891747, 6729.93270067298, 6764.8308792280095, 6770.289119642465, 6773.72905083796, 6345.111684364193, 6363.331850155713, 6366.172397588331, 6457.4188323050685, 6469.870602587922, 6862.656867156722, 6993.125859267591, 7099.751508697171, 7170.892436613507, 7199.89200161998, 6692.86614267712, 6705.932940670628, 6741.1236539249585, 6818.761343352959, 6826.283240259701, 6738.460923126138, 6845.281245469154, 6864.176298844171, 6876.140482439695, 6891.965540172267, 6409.455196308366, 6761.256261811197, 6843.418309443654, 6862.382385585322, 6866.519343645897, 6690.83272918181, 6771.0, 6892.414144797648, 6895.862082758316, 6898.8620227596175, 5210.426853046162, 5318.840434786963, 5340.732963351817, 5378.623496355296, 5476.479734425223, 4687.039156972813, 4710.599599034052, 4768.928466073012, 4775.6657034007285, 4795.040991801654, 5917.289925209003, 5950.940490595125, 5973.044312909914, 5991.071383935497, 5999.400059993965, 6810.080639113657, 6849.1780986281965, 6849.280825513349, 6950.957356396581, 6966.616836073963, 5702.116171993348, 5848.678322692208, 5869.911951320733, 5927.110933359944, 5997.0404735242155, 5904.143899134601, 6026.337102918676, 6035.245594300713, 6051.969740151271, 6057.394260573996, 6674.199096108498, 6698.0, 6723.260441351447, 6730.596164230162, 6822.590644561342, 6685.33146685347, 6841.350071743176, 6911.2397636259975, 6916.654167291515, 7039.049728286615, 6527.314631963765, 6545.2800191979795, 6545.607263564011, 6556.147700798866, 6559.573627714183, 6675.065490831191, 6684.7326106957125, 6697.53117281805, 6700.966495167493, 6703.564268322543, 6687.898089172152, 6740.292269311652, 6769.593824370553, 6782.898256526255, 6790.626515541692, 6466.967665161644, 6511.967440162769, 6517.837054073686, 6530.542861999615, 6535.477161826947, 6504.38208370204, 6553.0, 6556.737730490918, 6556.770513032021, 6691.698873550605, 6593.274739778524, 6598.1422415085735, 6657.73369065232, 6677.76627818024, 6735.865282694221, 6679.866402672016, 6710.966445167743, 6717.596944183365, 6743.224529179011, 6839.726410943506, 6373.776917807854, 6459.4832413405875, 6489.221293444817, 6586.1438013058, 6628.602283862983], "value": 6224.904055176338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.5598798654732, 816.7182322098873, 833.366641352572, 864.5677161419294, 864.85729854574, 38933.0, 39433.21133577327, 39521.80239098801, 39559.40660890082, 39750.60249397505, 35041.824790876075, 35157.12107197321, 35462.8226858866, 35666.2866742665, 35772.46341304883, 6853.897191542118, 6979.825504362406, 7013.8597228055405, 7016.087908571879, 7020.648967551628, 6832.180138383376, 6888.483363747714, 6973.825654358656, 6992.6154061526595, 7011.368976792088, 6903.447724182053, 6938.444924406035, 6954.582725036514, 7559.130699969492, 7750.14748377678, 7564.621768911533, 7663.310302072785, 7671.731489397845, 7716.112647045606, 7752.961235193788, 7521.548707077538, 7562.168161502231, 7575.469717119804, 7601.581912994783, 7616.238376162395, 35942.82028589866, 36329.27341453156, 36690.63309366899, 36855.07862303437, 37324.62675373239, 3482.547268855058, 3518.630543792916, 3520.964790352115, 3524.8766293179615, 3527.4356103023392, 31086.911958081586, 31096.533551996738, 31237.53143702846, 31301.843490782627, 31404.528932066038, 5136.049830781318, 5156.1750119981, 5178.741062946838, 5215.6609820361555, 5280.1815718563685, 184944.0, 186444.0, 187777.0, 188150.0, 188392.0, 45845.0, 46184.76907615441, 46411.53588464072, 46417.303740443924, 46537.7673111639, 47860.28209576859, 47894.76052619715, 47903.0, 48143.277850832266, 48236.27645585319, 14734.705305894036, 15038.54884353471, 15048.32282547288, 15055.322510487054, 15090.24548772557, 12257.325847078318, 12369.072319576067, 12376.81434778479, 12397.0, 12402.937985310016, 13515.25666088355, 13563.118397304144, 13636.454541818415, 13636.909047276195, 13850.515231966832, 5567.3040869891265, 5589.608727389125, 5597.188407680864, 5602.299712535933, 5784.681842498619, 988.6935050134481, 991.9752006199902, 996.5117092624562, 1010.7271036820165, 1014.3862962907482, 22389.216377427038, 22720.0, 22835.173186145068, 22893.25772526272, 23269.88365058164, 1082.4953314892307, 1105.5798796457455, 1107.213878146525, 1116.7319843237726, 1118.697951553076, 11872.703182420508, 12006.699832504082, 12042.337671428155, 12054.337011464278, 12099.75800484003, 218796.0, 219479.0, 223102.0, 224096.0, 224480.0, 42382.78808605937, 43337.78331108324, 48854.75572622114, 49011.0, 49468.75265623721, 1419.8012278281049, 1437.4609521429463, 1439.2300119436052, 1443.3865607116934, 1455.9272036398138, 26762.464750705265, 27392.0, 27658.0, 27828.30429239285, 28234.71765282321, 36414.4537831938, 36511.634883650826, 36522.452163218106, 36657.26685466329, 36915.8154209238, 205948.0, 207452.0, 207829.0, 209478.0, 209709.0, 33913.15217119493, 34323.828380857936, 34503.654963451045, 34652.13369665779, 34697.653023470455, 43619.0, 43710.56289437192, 43948.340774887765, 44488.55511444844, 45054.77472612747, 32800.0, 33162.17094572655, 33213.667863321054, 33249.501257480675, 33395.66604334023, 32398.83800581076, 33002.0, 33339.0, 33479.49780753242, 33639.83180084182, 36088.45867312045, 36145.457818133276, 36608.26783464369, 36704.63295367012, 36745.63254367529, 31392.0, 31977.840110799298, 32010.19974500656, 32369.19077022999, 33022.33955320928, 23178.249302446384, 23993.28020159398, 24360.26919192427, 24715.752842471346, 24926.0], "value": 16813.365617256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.3766886914483, 551.555997422075, 562.6174201542949, 575.5654480866946, 576.9624974376666, 21261.57476850462, 21956.560868782613, 21962.45093872654, 21978.45053873654, 22005.0, 24271.150509732164, 25375.365615859613, 25508.617370739456, 25601.23196304114, 25685.871570642168, 6633.734650613982, 6761.4590832733265, 6782.1183246177925, 6803.251642319341, 6806.591604503746, 3919.8432062717457, 6627.602343859384, 6635.303293154222, 6663.0, 6689.2976237495095, 4060.939085913714, 6849.657517124148, 7210.7476238331665, 7218.602976836272, 7222.241664625191, 7123.394511466531, 7137.4290056795335, 7157.999999999974, 7204.783856484314, 7217.4586905982, 6971.477139214579, 6993.720251189946, 6999.23008469068, 7005.614691191982, 7015.684294206773, 29202.269943251376, 29435.70564294351, 30053.69946300531, 30382.54426183609, 30958.690413095806, 2103.0, 2140.678898165272, 2141.154244073582, 2146.377550510366, 2151.268568686654, 19972.300969466145, 20451.079701413473, 20457.079431425474, 20624.69062964057, 20660.896695516578, 2511.2717311979504, 2538.631898374725, 2594.377349436141, 2606.569915963864, 2609.321576390133, 138341.0, 141463.29268353592, 141711.29144354316, 142322.28838855738, 143137.0, 18872.39111217648, 20375.453068366452, 21526.246581369578, 21541.353759387242, 23150.07399703993, 41104.0, 41438.37842432366, 41558.37662435066, 41571.0, 41656.1668766629, 10850.457477126112, 10879.619213327655, 11140.164487663458, 11229.831552526719, 11238.100951923827, 9128.90871091294, 9176.49529275883, 9196.310276729271, 9290.767730806649, 9293.581788819383, 8812.339074569432, 10758.946205268923, 11159.497822598003, 11396.886031139748, 11476.713082173012, 2791.1626512046305, 2846.2742000789667, 2860.613817134702, 2876.7698584113223, 2943.3083225442006, 944.2776276148752, 981.6564202529057, 990.7622170678985, 1001.0540039662594, 1015.7511409704522, 19404.611907761766, 19513.90243048804, 19553.902230488755, 19767.209311627663, 20209.292674756314, 1043.293186271096, 1046.3303485769113, 1055.2402270365324, 1055.8416237564427, 1059.9841002384971, 11080.335179889233, 11193.440327983568, 11196.216264861545, 11234.943825280821, 11259.324440533594, 492555.0, 518753.0, 528766.0, 543987.0, 545366.0, 116980.0, 119475.40262298632, 121055.39472302582, 123315.38342308231, 123616.38191808983, 1199.7180662544295, 1224.7305592769576, 1229.1396022783908, 1241.944112514939, 1242.2794779028322, 20538.17847286092, 20707.585848282648, 20794.792052079287, 20816.791832081486, 21232.469188270417, 55907.0, 56596.43403565911, 56907.715461424086, 57256.0, 57691.134632981375, 71784.64107679637, 74736.0, 77001.61499192468, 77947.0, 79380.0, 14333.283335833376, 14603.269836508345, 14776.187309698069, 14786.112833230041, 14976.550703478913, 23086.422839428476, 23189.42026449352, 23194.536109277382, 23323.416914577272, 23389.649155263025, 18563.164657590172, 18627.72058419152, 18657.880527167872, 18755.812441875405, 18881.622367552845, 16664.41674541385, 16753.497395078168, 17253.741193882353, 17263.482095537154, 17269.481915542554, 17964.101794910464, 18697.81302187015, 18871.90564047171, 19132.0, 19605.31381401644, 14360.784588231394, 14439.639009024859, 14567.198804065878, 14567.271636418349, 14595.124292542481, 18223.179956901706, 18385.90807045956, 18472.07639617987, 18559.814401856347, 18676.906615466836], "value": 12658.757757182284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.5502456677013, 1398.1960372785645, 1398.7552178368783, 1399.251400500732, 1405.2552147361903, 14654.926725366371, 15224.619384515392, 15431.45989890354, 15467.38130474781, 15888.285027173775, 15964.76052859208, 16165.35338586458, 16190.75713864293, 16209.108499032549, 16228.594285142877, 2712.227015300645, 2764.04640399062, 2768.43247134337, 2770.1689493152076, 2772.50094982903, 2636.6835979682464, 2649.668791401075, 2727.9590806137926, 2782.1792571191445, 2805.705400932903, 2783.4154827486254, 2786.512360336943, 2809.761170300527, 2819.8026138170235, 2820.2667306500357, 2650.3639126609573, 2676.812623116383, 2694.312950197707, 2694.932626684329, 2699.5545734953707, 2717.782577393804, 2728.45430913818, 2729.686086100104, 2731.207949694606, 2732.1393760965234, 14854.2572871356, 15016.24918754058, 15153.772693409608, 15154.166520841349, 15155.545333639899, 7748.883766743504, 7833.451658383916, 7951.165127661628, 8018.198180181994, 8047.114817370085, 5121.871953201163, 5243.842684719464, 5355.3305836770405, 5375.16684913839, 5384.91922621161, 1866.150901339887, 1905.8951757653324, 1915.6456055629753, 1955.9706604400944, 1963.2049020146721, 26520.602190967344, 26565.0, 26574.734252657418, 26794.732052679417, 26819.195424137306, 6727.66361681914, 6784.830379240559, 6795.626240556817, 6991.545549539263, 7050.224475307712, 17295.30818767235, 17465.03942283161, 17472.30110795554, 17473.82526174722, 17487.213075411637, 7912.327452166515, 7937.0, 7981.161977992228, 7985.121636619967, 8058.033036035596, 6886.10480637524, 7029.332213439715, 7043.330883566053, 7161.677724502306, 7401.111866576045, 4640.211164102111, 4977.502249775066, 4978.975105124451, 5047.646664733434, 5235.712035837989, 1343.2209318595192, 1349.1432940083118, 1368.9589312320647, 1374.305975482375, 1376.9655758605916, 862.185234952976, 872.9345299102592, 879.2087121590491, 879.6041781198486, 892.7009451833578, 8381.874271885927, 8393.874091888627, 8452.957735211285, 8503.362247831314, 8539.530325832138, 980.7401038724744, 988.619381538113, 998.0967224661692, 999.0459111548454, 1011.0647650922867, 4931.457539670633, 4980.402351717745, 4993.7503124843615, 5023.924641130386, 5324.254604355393, 21184.470388240108, 21229.15083396647, 21865.453363666034, 22018.889905550368, 22036.11855525761, 19704.70442943357, 20422.897885510476, 20427.28504502365, 21880.45298867541, 22162.556748864932, 10892.727681808019, 10970.434713312297, 11066.833997490045, 11213.66359009231, 11221.382823944761, 8752.256058234867, 8768.693095741874, 8959.776005599912, 8968.865467018131, 9035.27717782589, 18701.25194992185, 18723.90638046801, 18891.811081889005, 19072.237110515423, 19217.23131074797, 18782.436526904214, 19012.334568290044, 19103.426897193105, 19143.138558765168, 19901.203951841766, 11656.417179141179, 11719.41402929833, 11779.528818847493, 11794.823077653671, 11895.286282823059, 12137.878621213675, 12654.30401327899, 14246.928765356108, 14438.783418248524, 14452.0, 10650.73373165646, 11528.884711152781, 11666.358350290815, 11763.529458821893, 11804.704882377666, 11026.834597481205, 11089.0, 11299.887001129884, 11411.885881141083, 11454.713632159262, 9944.552495137592, 10005.899941000496, 10108.747281318027, 10130.189584833048, 10148.695539133838, 7001.404880585207, 7094.290570942864, 7129.287071292829, 7131.643417829192, 7323.963380183065, 7371.336579707852, 7415.888761668687, 7417.629118544159, 7441.702331906879, 7479.0], "value": 6692.923567491263, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.85249859657307, 504.27888119988427, 525.7003508000437, 530.3503208569502, 530.3979982719613, 6366.490680745541, 6379.553431259814, 6385.33981164897, 6446.32313607071, 6473.126127972722, 6149.385061493859, 6205.875882482348, 6215.5338349623735, 6274.4039316265, 6289.874202515947, 5042.0, 5051.469595692454, 5052.747362631872, 5065.290859279695, 5082.720450375228, 5044.47033061527, 5067.518585734368, 5068.113080210948, 5077.720725360104, 5085.66943148696, 4835.734034628094, 4937.481564435737, 4973.254011898208, 4998.775055122528, 5031.597472202233, 4951.579115775164, 5038.697678139323, 5058.317127187837, 5059.772310246048, 5073.467285934979, 4468.039371535103, 4498.4358915418225, 4513.729176249402, 4538.273876179828, 4546.136234115507, 6158.384161583851, 6216.658083805389, 6229.4704950079295, 6267.62394256346, 6274.2784579773, 5728.9115068137335, 5750.281214848144, 5751.19483272338, 5753.683547404891, 5770.307563092456, 6571.704273307712, 6665.366790154928, 6674.299198584127, 6702.262751097375, 6711.295313992009, 4821.517848215186, 4853.951460485385, 4861.975690121527, 4868.075065737498, 4896.730679812609, 6822.692978815965, 6923.584584924921, 6939.826504337331, 6967.268436814113, 6983.406410455117, 5056.165732654071, 5060.367454068241, 5078.5937125029905, 5083.6187285952965, 5107.795688172431, 5106.080905436983, 5135.460776618476, 5170.689758614495, 5188.0, 5189.377274727057, 5665.575081868877, 5679.466544033171, 5719.342275638355, 5727.885442291131, 5736.885262294731, 6559.606423614503, 6610.305917878553, 6705.832354191087, 6725.39471447572, 6727.360900714424, 1691.365737848307, 1765.4791836408033, 1768.8054314025446, 1790.1228398084845, 1796.4281253902834, 1114.3648120571197, 1153.382940127028, 1179.7876382251106, 1214.5688280660415, 1235.7034311765112, 5743.10981797822, 5771.422857714195, 5799.159121927297, 5847.1229315603, 5884.293884733774, 6692.783546365758, 6718.49611279156, 6777.661116944231, 6778.389944904884, 6789.15135608049, 5621.550275977912, 5684.403137670568, 5756.416985329068, 5807.925533776181, 5855.443732845373, 3489.337025965109, 3494.2312691207894, 3550.396432606463, 3566.91082722934, 3567.375709250871, 6432.807015789534, 6451.161349024596, 6480.569786330127, 6521.250056243498, 6559.508036897252, 6734.595924244561, 6844.486663500158, 6867.141607299088, 6899.861043076662, 6904.965475172692, 6420.0, 6440.227172739301, 6458.22501299847, 6528.804135875931, 6553.2136143663065, 6575.0, 6630.701618427086, 6671.733130674718, 6696.966515167393, 6779.593224406552, 6532.673366331759, 6544.411003009752, 6620.0, 6633.0, 6749.932500675127, 6520.413162815369, 6580.967095164494, 6591.177117272066, 6615.867682646416, 6638.834029149117, 4981.900361992813, 5009.774560144875, 5053.043969277866, 5062.165187495015, 5065.113605119163, 6722.294159113223, 6722.630255336004, 6732.394084532416, 6805.761798337233, 6809.21694005176, 6491.642959637265, 6534.313897040933, 6544.738210471528, 6544.869102617826, 6559.573627714183, 6340.682965851597, 6361.650109243851, 6363.600007998233, 6401.135846660642, 6554.311797261219, 6068.726907289094, 6463.0, 6534.4772418205475, 6550.705218265285, 6595.934040659532, 6617.966910165418, 6661.16735408074, 6689.49828762835, 6699.698513566804, 6701.731930722716, 6398.168238129014, 6407.327230640715, 6429.421352078335, 6506.154199953976, 6521.445677117498], "value": 5081.904471861953, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.845327067763, 898.3217670658654, 921.2998121427713, 921.6129225725199, 925.5326060339528, 18592.0, 19334.129964151613, 19339.22643094278, 19361.322353717624, 19396.90301548492, 19791.307304244354, 21249.25627603034, 21387.786122138776, 21395.786042139574, 21564.784352156476, 963.1283688262116, 974.9463779492125, 980.3382716666257, 983.54265266651, 984.8424252119662, 938.3947353956694, 991.6380521109779, 994.9253805964545, 995.8904520502739, 996.9850452243222, 1033.4264483211814, 1050.5955207245227, 1052.1582733812918, 1054.8259537176357, 1056.8520407142967, 1038.4755698372273, 1039.5789705169418, 1040.1107053469289, 1042.9582816687323, 1043.1237760281363, 766.4022062791032, 767.8656235158825, 768.7616838779941, 769.2384539306047, 770.0336078221852, 19116.5220869478, 19294.13176407065, 19457.902710486498, 19573.119209635457, 19817.50456238591, 20437.489062773402, 20512.487187820276, 20968.685469717966, 21016.474588135265, 21041.684374734392, 16374.426895058736, 16405.753913691304, 16610.418635347705, 16761.7485737714, 16762.664746705, 3664.395374763161, 3695.7412981091334, 3696.149885526317, 3696.8706095286807, 3698.519192504984, 121782.0, 127643.0, 128255.0, 130065.34967325197, 132196.0, 16313.10277934725, 16619.83380166207, 16670.66658666844, 16695.0, 16712.74930876038, 28880.277993050342, 30574.23564410863, 30934.0719778407, 30935.226619334248, 30947.845260774004, 8006.079300880357, 8049.315808156372, 8082.797930051795, 8091.959540202379, 8111.756647300473, 4012.6990475714438, 4089.509258888893, 4091.263572556909, 4093.7953102344763, 4098.959010409858, 4778.283257511401, 5525.640833345819, 5575.944240557543, 5733.397993210736, 5833.79581714638, 1064.3720205078885, 1093.1091160704, 1111.5887121764838, 1111.7554138089608, 1120.288616728367, 664.7307840324676, 664.7440735316937, 668.4719071933216, 673.6699017481399, 683.1528904158906, 11942.820857687142, 12807.743845123045, 13483.730325393437, 13485.325733713471, 13592.048556601141, 678.0947435173999, 682.1984168601873, 683.1051322767191, 687.848673291875, 702.0978043214445, 5733.799317023884, 5804.952399990039, 5839.678817664984, 5943.3462319144855, 6001.969990150109, 99585.50207248918, 103539.0, 104282.0, 104851.4757426208, 110129.0, 90763.80282253191, 91154.0, 92774.53612732029, 94580.0, 99379.0, 82804.0, 84093.0, 84598.57700711457, 86129.70805437924, 86595.0, 12358.691032723895, 12469.688257793629, 12856.871431285568, 13374.0, 13403.664908377368, 38629.4205586922, 39320.80339598398, 40229.79885100556, 40545.0, 40571.59428405678, 67966.66016669886, 69000.0, 69262.65368673124, 70699.29300706927, 71190.64404677943, 18775.155118019447, 19170.904145479184, 19233.80766192376, 19253.90373048126, 19490.415287541397, 21046.894765526074, 21179.47051323729, 21479.140834367074, 21592.24427145105, 21607.891960540095, 17327.2202750874, 17467.82532174662, 17489.56276093108, 18515.166817493515, 18930.43208703741, 18051.729224061914, 18162.818371816113, 18866.434006979813, 19374.2250309986, 19597.608047839247, 17522.211500482255, 17648.823511765233, 18015.099245037956, 18791.34230301933, 19461.221551138362, 12816.423260953094, 12886.742265154457, 12914.483420663444, 12928.547500837425, 13465.39405726725, 14445.85554144445, 14812.111273323635, 14929.477468288558, 14977.1013739176, 15272.465463708717], "value": 9196.74493971133, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 102.0, 119.0, 113.0, 109.0, 118.0, 102.0, 111.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 149.0, 181.0, 119.0, 152.0, 148.0, 116.0, 171.0, 120.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 167.0, 163.0, 173.0, 170.0, 162.0, 166.0, 168.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 170.0, 80.0, 74.0, 74.0, 74.0, 157.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 135.0, 80.0, 82.0, 80.0, 127.0, 79.0, 82.0, 137.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 117.0, 117.0, 114.0, 115.0, 114.0, 118.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 161.0, 154.0, 150.0, 148.0, 148.0, 149.0, 149.0, 150.0, 148.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 101.0, 94.0, 102.0, 94.0, 95.0, 95.0, 100.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 52.0, 53.0, 63.0, 52.0, 53.0, 53.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 43.0, 39.0, 42.0, 38.0, 39.0, 46.0, 40.0, 39.0, 42.0], "value": 41.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 75.0, 80.0, 79.0, 75.0, 79.0, 86.0, 80.0, 76.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 121.0, 134.0, 126.0, 123.0, 121.0, 119.0, 119.0, 167.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 169.0, 178.0, 169.0, 171.0, 179.0, 180.0, 172.0, 179.0, 176.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 71.0, 65.0, 63.0, 65.0, 68.0, 69.0, 66.0, 67.0], "value": 67.0, "unit": "score"}]}]} 16:13:26 INFO - Return code: 0 16:13:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:26 INFO - # TBPL SUCCESS # 16:13:26 INFO - Running post-action listener: _package_coverage_data 16:13:26 INFO - Running post-action listener: _resource_record_post_action 16:13:26 INFO - [mozharness: 2017-09-05 23:13:26.384719Z] Finished run-tests step (success) 16:13:26 INFO - Running post-run listener: _resource_record_post_run 16:13:26 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 3686400; Write bytes: 398065664; Read time: 5152; Write time: 443864 16:13:26 INFO - TinderboxPrint: CPU usage
13.3% 16:13:26 INFO - TinderboxPrint: I/O read bytes / time
3,686,400 / 5,152 16:13:26 INFO - TinderboxPrint: I/O write bytes / time
398,065,664 / 443,864 16:13:26 INFO - TinderboxPrint: CPU idle
8,263.3 (86.7%) 16:13:26 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 16:13:26 INFO - TinderboxPrint: Swap in / out
0 / 0 16:13:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 104378368; Read time: 92; Write time: 145764 16:13:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:13:26 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3678208; Write bytes: 290557952; Read time: 5052; Write time: 297820 16:13:27 INFO - Running post-run listener: _upload_blobber_files 16:13:27 INFO - Blob upload gear active. 16:13:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:27 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 16:13:27 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'] 16:13:27 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 16:13:27 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:34 INFO - (blobuploader) - INFO - Done attempting. 16:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:35 INFO - (blobuploader) - INFO - Done attempting. 16:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:36 INFO - (blobuploader) - INFO - Done attempting. 16:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:37 INFO - (blobuploader) - INFO - Done attempting. 16:13:37 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:37 INFO - Return code: 0 16:13:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9673237fe9c8d636a2633586079c977a0cfcc982c677f8b90a0406f50f7b9b0031a3ef9dba01ec73a0055d50c1eb8ea0518779d3a2847d443854fd4f003d99f7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e586b00c9b0d6dca985994b738976bb7c519d50752dfdefe6478cd51e3d27f3fe5b9c5756c2f686738d29adb5f6f4c7e7f1334a2c079f4c6e72d1832d09dbc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a87ddf979469288511a4647d199d506c23d5a53d628c7fc5cfa1f5c88dc3f502ef7628fbcc7723692f34905a92481ccaf80aa5962ca62d54c44de4d68e4a8a9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9fef94ad0ab0107e9699b7b3e9c6b2a333b7a17c56e677924c271042b39abae6dd97c551229b5c4b47c32315104699a4857b49e22e74b0d218520ff2c0db00f"} 16:13:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:37 INFO - Contents: 16:13:37 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9673237fe9c8d636a2633586079c977a0cfcc982c677f8b90a0406f50f7b9b0031a3ef9dba01ec73a0055d50c1eb8ea0518779d3a2847d443854fd4f003d99f7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e586b00c9b0d6dca985994b738976bb7c519d50752dfdefe6478cd51e3d27f3fe5b9c5756c2f686738d29adb5f6f4c7e7f1334a2c079f4c6e72d1832d09dbc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a87ddf979469288511a4647d199d506c23d5a53d628c7fc5cfa1f5c88dc3f502ef7628fbcc7723692f34905a92481ccaf80aa5962ca62d54c44de4d68e4a8a9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9fef94ad0ab0107e9699b7b3e9c6b2a333b7a17c56e677924c271042b39abae6dd97c551229b5c4b47c32315104699a4857b49e22e74b0d218520ff2c0db00f"} 16:13:37 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:37 INFO - Copying logs to upload dir... 16:13:37 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.545798 ========= master_lag: -0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-09-05 16:13:37.004870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 16:13:37.012450) ========= 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=eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670 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/9673237fe9c8d636a2633586079c977a0cfcc982c677f8b90a0406f50f7b9b0031a3ef9dba01ec73a0055d50c1eb8ea0518779d3a2847d443854fd4f003d99f7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e586b00c9b0d6dca985994b738976bb7c519d50752dfdefe6478cd51e3d27f3fe5b9c5756c2f686738d29adb5f6f4c7e7f1334a2c079f4c6e72d1832d09dbc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a87ddf979469288511a4647d199d506c23d5a53d628c7fc5cfa1f5c88dc3f502ef7628fbcc7723692f34905a92481ccaf80aa5962ca62d54c44de4d68e4a8a9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9fef94ad0ab0107e9699b7b3e9c6b2a333b7a17c56e677924c271042b39abae6dd97c551229b5c4b47c32315104699a4857b49e22e74b0d218520ff2c0db00f"} build_url:https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/ciQLVfAyTVS5ODxEPFePfg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9673237fe9c8d636a2633586079c977a0cfcc982c677f8b90a0406f50f7b9b0031a3ef9dba01ec73a0055d50c1eb8ea0518779d3a2847d443854fd4f003d99f7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e586b00c9b0d6dca985994b738976bb7c519d50752dfdefe6478cd51e3d27f3fe5b9c5756c2f686738d29adb5f6f4c7e7f1334a2c079f4c6e72d1832d09dbc", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a87ddf979469288511a4647d199d506c23d5a53d628c7fc5cfa1f5c88dc3f502ef7628fbcc7723692f34905a92481ccaf80aa5962ca62d54c44de4d68e4a8a9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9fef94ad0ab0107e9699b7b3e9c6b2a333b7a17c56e677924c271042b39abae6dd97c551229b5c4b47c32315104699a4857b49e22e74b0d218520ff2c0db00f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 16:13:37.047158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:13:37.047490) ========= 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=eca2ab57546de7b41f256b19000001ef-1504651957.824569-462919670 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 16:13:37.126781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 16:13:37.127648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 16:13:37.127953) ========= ========= Total master_lag: -0.07 =========