builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-075 starttime: 1506469946.57 results: success (0) revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.571309) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.571705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.571983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.785901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:26.789171) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 16:52:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.3M=0s 2017-09-26 16:52:27 (53.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.494630 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.325217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.325517) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.378114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.378453) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --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 b7d8ae4a03c62e549b9d82595b1d1964f0af70cd --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=fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 16:52:27,419 truncating revision to first 12 chars 2017-09-26 16:52:27,419 Setting DEBUG logging. 2017-09-26 16:52:27,419 attempt 1/10 2017-09-26 16:52:27,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7d8ae4a03c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 16:52:27,669 unpacking tar archive at: mozilla-central-b7d8ae4a03c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.940737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.944093) ========= script_repo_revision: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.944505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.944789) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 16:52:27.958305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-26 16:52:27.958579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:28 INFO - MultiFileLogger online at 20170926 16:52:28 in /builds/slave/test 16:52:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:52:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:28 INFO - {'append_to_log': False, 16:52:28 INFO - 'base_work_dir': '/builds/slave/test', 16:52:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:52:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:28 INFO - 'branch': 'Firefox-Non-PGO', 16:52:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:28 INFO - 'code_coverage': False, 16:52:28 INFO - 'config_files': ('talos/linux_config.py',), 16:52:28 INFO - 'default_actions': ('clobber', 16:52:28 INFO - 'read-buildbot-config', 16:52:28 INFO - 'download-and-extract', 16:52:28 INFO - 'populate-webroot', 16:52:28 INFO - 'create-virtualenv', 16:52:28 INFO - 'install', 16:52:28 INFO - 'setup-mitmproxy', 16:52:28 INFO - 'run-tests'), 16:52:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:28 INFO - 'disable_ccov_upload': False, 16:52:28 INFO - 'disable_stylo': False, 16:52:28 INFO - 'download_minidump_stackwalk': True, 16:52:28 INFO - 'download_symbols': 'ondemand', 16:52:28 INFO - 'enable_stylo': False, 16:52:28 INFO - 'enable_webrender': False, 16:52:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:52:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:28 INFO - 'gecko_profile': False, 16:52:28 INFO - 'gecko_profile_interval': 0, 16:52:28 INFO - 'installer_path': 'installer.exe', 16:52:28 INFO - 'log_level': 'info', 16:52:28 INFO - 'log_name': 'talos', 16:52:28 INFO - 'log_to_console': True, 16:52:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:28 INFO - 'opt_config_files': (), 16:52:28 INFO - 'pip_index': False, 16:52:28 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:52:28 INFO - 'system_bits': '32', 16:52:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:28 INFO - 'title': 'talos-linux64-ix-075', 16:52:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:28 INFO - 'use_talos_json': True, 16:52:28 INFO - 'verify': 'False', 16:52:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:28 INFO - 'work_dir': 'build'} 16:52:28 INFO - [mozharness: 2017-09-26 23:52:28.216160Z] Running clobber step. 16:52:28 INFO - Running pre-action listener: _resource_record_pre_action 16:52:28 INFO - Running main action method: clobber 16:52:28 INFO - rmtree: /builds/slave/test/build 16:52:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:29 INFO - Running post-action listener: _resource_record_post_action 16:52:29 INFO - [mozharness: 2017-09-26 23:52:29.171489Z] Finished clobber step (success) 16:52:29 INFO - [mozharness: 2017-09-26 23:52:29.171586Z] Running read-buildbot-config step. 16:52:29 INFO - Running pre-action listener: _resource_record_pre_action 16:52:29 INFO - Running main action method: read_buildbot_config 16:52:29 INFO - Using buildbot properties: 16:52:29 INFO - { 16:52:29 INFO - "project": "", 16:52:29 INFO - "product": "firefox", 16:52:29 INFO - "who": "kwierso@gmail.com", 16:52:29 INFO - "installer_path": "public/build/target.tar.bz2", 16:52:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:52:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:52:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 16:52:29 INFO - "stage_platform": "linux64", 16:52:29 INFO - "basedir": "/builds/slave/test", 16:52:29 INFO - "buildnumber": 71, 16:52:29 INFO - "platform": "ubuntu64_hw", 16:52:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:52:29 INFO - "slavebuilddir": "test", 16:52:29 INFO - "taskId": "dnccdS13RoeFCULGbhakvw", 16:52:29 INFO - "branch": "mozilla-central", 16:52:29 INFO - "script_repo_revision": "production", 16:52:29 INFO - "revision": "b7d8ae4a03c62e549b9d82595b1d1964f0af70cd", 16:52:29 INFO - "slavename": "talos-linux64-ix-075", 16:52:29 INFO - "repo_path": "mozilla-central" 16:52:29 INFO - } 16:52:29 INFO - Finding installer, test and symbols from parent task. 16:52:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnccdS13RoeFCULGbhakvw'}, attempt #1 16:52:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dnccdS13RoeFCULGbhakvw'}, attempt #1 16:52:30 INFO - Task dependencies: HLKvdi3eRuyWAkkyUmZMZA 16:52:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA'}, attempt #1 16:52:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json 16:52:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip 16:52:30 INFO - Running post-action listener: _resource_record_post_action 16:52:30 INFO - [mozharness: 2017-09-26 23:52:30.524201Z] Finished read-buildbot-config step (success) 16:52:30 INFO - [mozharness: 2017-09-26 23:52:30.524421Z] Running download-and-extract step. 16:52:30 INFO - Running pre-action listener: _resource_record_pre_action 16:52:30 INFO - Running main action method: download_and_extract 16:52:30 INFO - mkdir: /builds/slave/test/build/tests 16:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:30 INFO - trying https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json 16:52:30 INFO - Downloading https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:52:31 INFO - Downloaded 989 bytes. 16:52:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:52:31 INFO - Using the following test package requirements: 16:52:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:52:31 INFO - u'common': [u'target.common.tests.zip'], 16:52:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:52:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:52:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:52:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:52:31 INFO - u'mozbase': [u'target.common.tests.zip'], 16:52:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:52:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:52:31 INFO - u'web-platform': [u'target.common.tests.zip', 16:52:31 INFO - u'target.web-platform.tests.tar.gz'], 16:52:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:52:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:52:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.common.tests.zip 16:52:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:52:31 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.common.tests.zip into memory 16:52:34 INFO - Content-Length response header: 54945817 16:52:34 INFO - Bytes received: 54945817 16:52:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.talos.tests.zip 16:52:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:52:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.talos.tests.zip into memory 16:52:46 INFO - Content-Length response header: 14513823 16:52:46 INFO - Bytes received: 14513823 16:52:46 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')]} 16:52:46 INFO - trying https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:46 INFO - Downloading https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:52:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:52:51 INFO - Downloaded 61702688 bytes. 16:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:51 INFO - mkdir: /builds/slave/test/properties 16:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:52:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:52:51 INFO - Contents: 16:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 16:52:51 INFO - Running post-action listener: _resource_record_post_action 16:52:51 INFO - Running post-action listener: find_tests_for_verification 16:52:51 INFO - Running post-action listener: set_extra_try_arguments 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.359603Z] Finished download-and-extract step (success) 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.359829Z] Running populate-webroot step. 16:52:51 INFO - Running pre-action listener: _resource_record_pre_action 16:52:51 INFO - Running main action method: populate_webroot 16:52:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:52:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tresize', 16:52:51 INFO - 'tcanvasmark']}, 16:52:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:52:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['dromaeo_css', 16:52:51 INFO - 'kraken']}, 16:52:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:52:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'tests': ['damp', 'tps']}, 16:52:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['damp', 'tps']}, 16:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:52:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['dromaeo_dom']}, 16:52:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:52:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['basic_compositor_video', 16:52:51 INFO - 'glvideo']}, 16:52:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:52:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['ts_paint_webext', 16:52:51 INFO - 'tp5o_webext']}, 16:52:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:52:51 INFO - 'ts_paint', 16:52:51 INFO - 'tpaint', 16:52:51 INFO - 'sessionrestore', 16:52:51 INFO - 'sessionrestore_many_windows', 16:52:51 INFO - 'sessionrestore_no_auto_restore', 16:52:51 INFO - 'tabpaint']}, 16:52:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['a11yr', 16:52:51 INFO - 'ts_paint', 16:52:51 INFO - 'tpaint', 16:52:51 INFO - 'sessionrestore', 16:52:51 INFO - 'sessionrestore_many_windows', 16:52:51 INFO - 'sessionrestore_no_auto_restore', 16:52:51 INFO - 'tabpaint']}, 16:52:51 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:52:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:52:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['perf_reftest_singletons']}, 16:52:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['perf_reftest']}, 16:52:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:52:51 INFO - 'tsvgr_opacity', 16:52:51 INFO - 'tart', 16:52:51 INFO - 'tscrollx', 16:52:51 INFO - 'tsvg_static']}, 16:52:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tsvgx', 16:52:51 INFO - 'tsvgr_opacity', 16:52:51 INFO - 'tart', 16:52:51 INFO - 'tscrollx', 16:52:51 INFO - 'tsvg_static']}, 16:52:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:52:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo'], 16:52:51 INFO - 'tests': ['tp5o']}, 16:52:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:52:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:52:51 INFO - 'talos_options': ['--mitmproxy', 16:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:52:51 INFO - '--firstNonBlankPaint'], 16:52:51 INFO - 'tests': ['tp6_google', 16:52:51 INFO - 'tp6_youtube', 16:52:51 INFO - 'tp6_amazon', 16:52:51 INFO - 'tp6_facebook']}, 16:52:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:52:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:52:51 INFO - 'talos_options': ['--disable-stylo', 16:52:51 INFO - '--mitmproxy', 16:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:52:51 INFO - '--firstNonBlankPaint'], 16:52:51 INFO - 'tests': ['tp6_google', 16:52:51 INFO - 'tp6_youtube', 16:52:51 INFO - 'tp6_amazon', 16:52:51 INFO - 'tp6_facebook']}, 16:52:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:52:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:52:51 INFO - 'talos_options': ['--stylo-threads=1', 16:52:51 INFO - '--mitmproxy', 16:52:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:52:51 INFO - '--firstNonBlankPaint'], 16:52:51 INFO - 'tests': ['tp6_google', 16:52:51 INFO - 'tp6_youtube', 16:52:51 INFO - 'tp6_amazon', 16:52:51 INFO - 'tp6_facebook']}, 16:52:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--xperf_path', 16:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:51 INFO - 'tests': ['tp5n']}, 16:52:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:52:51 INFO - 'talos_options': ['--disable-stylo', 16:52:51 INFO - '--xperf_path', 16:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:52:51 INFO - 'tests': ['tp5n']}}} 16:52:51 INFO - Running post-action listener: _resource_record_post_action 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.379254Z] Finished populate-webroot step (success) 16:52:51 INFO - [mozharness: 2017-09-26 23:52:51.379343Z] Running create-virtualenv step. 16:52:51 INFO - Running pre-action listener: _resource_record_pre_action 16:52:51 INFO - Running main action method: create_virtualenv 16:52:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:52:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:52:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:52:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:52:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:52:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:52:52 INFO - Installing pip...............done. 16:52:52 INFO - Return code: 0 16:52:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:52:52 INFO - Reading from file tmpfile_stdout 16:52:52 INFO - Output received: 16:52:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:52:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:52:52 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')]} 16:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:52 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')]} 16:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:52 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:52:52 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 16:52:52 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 16:52:52 INFO - Using env: {'DISPLAY': ':0', 16:52:52 INFO - 'HOME': '/home/cltbld', 16:52:52 INFO - 'LANG': 'en_US.UTF-8', 16:52:52 INFO - 'LANGUAGE': 'en_US:en', 16:52:52 INFO - 'LOGNAME': 'cltbld', 16:52:52 INFO - 'MAIL': '/var/mail/cltbld', 16:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:52 INFO - 'MOZ_NO_REMOTE': '1', 16:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:52 INFO - 'NO_EM_RESTART': '1', 16:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:52 INFO - 'PWD': '/builds/slave/test', 16:52:52 INFO - 'SHELL': '/bin/bash', 16:52:52 INFO - 'SHLVL': '1', 16:52:52 INFO - 'TERM': 'linux', 16:52:52 INFO - 'TMOUT': '86400', 16:52:52 INFO - 'USER': 'cltbld', 16:52:52 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:52 INFO - '_': '/tools/buildbot/bin/python'} 16:52:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:52:54 INFO - Downloading/unpacking pip>=1.5 16:52:54 INFO - Running setup.py egg_info for package pip 16:52:54 INFO - warning: no files found matching 'pip/cacert.pem' 16:52:54 INFO - warning: no files found matching '*.html' under directory 'docs' 16:52:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:52:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:52:54 INFO - Installing collected packages: pip 16:52:54 INFO - Found existing installation: pip 1.1 16:52:54 INFO - Uninstalling pip: 16:52:54 INFO - Successfully uninstalled pip 16:52:54 INFO - Running setup.py install for pip 16:52:54 INFO - warning: no files found matching 'pip/cacert.pem' 16:52:54 INFO - warning: no files found matching '*.html' under directory 'docs' 16:52:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:52:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:52:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:52:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:52:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:52:54 INFO - Successfully installed pip 16:52:54 INFO - Cleaning up... 16:52:54 INFO - Return code: 0 16:52:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:52:54 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')]} 16:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:54 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')]} 16:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:52:54 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 16:52:54 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 16:52:54 INFO - Using env: {'DISPLAY': ':0', 16:52:54 INFO - 'HOME': '/home/cltbld', 16:52:54 INFO - 'LANG': 'en_US.UTF-8', 16:52:54 INFO - 'LANGUAGE': 'en_US:en', 16:52:54 INFO - 'LOGNAME': 'cltbld', 16:52:54 INFO - 'MAIL': '/var/mail/cltbld', 16:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:54 INFO - 'MOZ_NO_REMOTE': '1', 16:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:54 INFO - 'NO_EM_RESTART': '1', 16:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:54 INFO - 'PWD': '/builds/slave/test', 16:52:54 INFO - 'SHELL': '/bin/bash', 16:52:54 INFO - 'SHLVL': '1', 16:52:54 INFO - 'TERM': 'linux', 16:52:54 INFO - 'TMOUT': '86400', 16:52:54 INFO - 'USER': 'cltbld', 16:52:54 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:54 INFO - '_': '/tools/buildbot/bin/python'} 16:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:54 INFO - Downloading/unpacking psutil>=3.1.1 16:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:55 INFO - Installing collected packages: psutil 16:52:55 INFO - Running setup.py install for psutil 16:52:55 INFO - building 'psutil._psutil_linux' extension 16:52:55 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 16:52:56 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 16:52:56 INFO - building 'psutil._psutil_posix' extension 16:52:56 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 16:52:56 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 16:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:52:56 INFO - Successfully installed psutil 16:52:56 INFO - Cleaning up... 16:52:56 INFO - Return code: 0 16:52:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:56 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:52:56 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 16:52:56 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 16:52:56 INFO - Using env: {'DISPLAY': ':0', 16:52:56 INFO - 'HOME': '/home/cltbld', 16:52:56 INFO - 'LANG': 'en_US.UTF-8', 16:52:56 INFO - 'LANGUAGE': 'en_US:en', 16:52:56 INFO - 'LOGNAME': 'cltbld', 16:52:56 INFO - 'MAIL': '/var/mail/cltbld', 16:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:56 INFO - 'MOZ_NO_REMOTE': '1', 16:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:56 INFO - 'NO_EM_RESTART': '1', 16:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:56 INFO - 'PWD': '/builds/slave/test', 16:52:56 INFO - 'SHELL': '/bin/bash', 16:52:56 INFO - 'SHLVL': '1', 16:52:56 INFO - 'TERM': 'linux', 16:52:56 INFO - 'TMOUT': '86400', 16:52:56 INFO - 'USER': 'cltbld', 16:52:56 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:56 INFO - '_': '/tools/buildbot/bin/python'} 16:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:52:58 INFO - Installing collected packages: mozsystemmonitor 16:52:58 INFO - Running setup.py install for mozsystemmonitor 16:52:58 INFO - Successfully installed mozsystemmonitor 16:52:58 INFO - Cleaning up... 16:52:58 INFO - Return code: 0 16:52:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:52:58 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')]} 16:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:52:58 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')]} 16:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:52:58 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 16:52:58 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 16:52:58 INFO - Using env: {'DISPLAY': ':0', 16:52:58 INFO - 'HOME': '/home/cltbld', 16:52:58 INFO - 'LANG': 'en_US.UTF-8', 16:52:58 INFO - 'LANGUAGE': 'en_US:en', 16:52:58 INFO - 'LOGNAME': 'cltbld', 16:52:58 INFO - 'MAIL': '/var/mail/cltbld', 16:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:52:58 INFO - 'MOZ_NO_REMOTE': '1', 16:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:52:58 INFO - 'NO_EM_RESTART': '1', 16:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:52:58 INFO - 'PWD': '/builds/slave/test', 16:52:58 INFO - 'SHELL': '/bin/bash', 16:52:58 INFO - 'SHLVL': '1', 16:52:58 INFO - 'TERM': 'linux', 16:52:58 INFO - 'TMOUT': '86400', 16:52:58 INFO - 'USER': 'cltbld', 16:52:58 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:52:58 INFO - '_': '/tools/buildbot/bin/python'} 16:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:52:58 INFO - Downloading/unpacking jsonschema==2.5.1 16:52:58 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 16:52:58 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 16:52:58 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 16:52:58 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 16:52:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:52:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:52:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:52:59 INFO - warning: no files found matching '*.txt' 16:52:59 INFO - no previously-included directories found matching 'build' 16:52:59 INFO - no previously-included directories found matching 'dist' 16:52:59 INFO - no previously-included directories found matching '.git*' 16:52:59 INFO - Installing collected packages: jsonschema, functools32 16:52:59 INFO - Running setup.py install for functools32 16:53:00 INFO - warning: no files found matching '*.txt' 16:53:00 INFO - no previously-included directories found matching 'build' 16:53:00 INFO - no previously-included directories found matching 'dist' 16:53:00 INFO - no previously-included directories found matching '.git*' 16:53:00 INFO - Successfully installed jsonschema functools32 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:53:00 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')]} 16:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 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')]} 16:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:53:00 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 16:53:00 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 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:53:00 INFO - Cleaning up... 16:53:00 INFO - Return code: 0 16:53:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:00 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')]} 16:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:00 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')]} 16:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:00 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:53:00 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 16:53:00 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 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:00 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 16:53:00 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 16:53:00 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 16:53:00 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 16:53:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:02 INFO - Downloading docopt-0.6.1.tar.gz 16:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:02 INFO - Running setup.py install for blobuploader 16:53:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:02 INFO - Running setup.py install for requests 16:53:02 INFO - Running setup.py install for docopt 16:53:02 INFO - Successfully installed blobuploader requests docopt 16:53:02 INFO - Cleaning up... 16:53:02 INFO - Return code: 0 16:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:02 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')]} 16:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:02 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')]} 16:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:02 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:53:02 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 16:53:02 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 16:53:02 INFO - Using env: {'DISPLAY': ':0', 16:53:02 INFO - 'HOME': '/home/cltbld', 16:53:02 INFO - 'LANG': 'en_US.UTF-8', 16:53:02 INFO - 'LANGUAGE': 'en_US:en', 16:53:02 INFO - 'LOGNAME': 'cltbld', 16:53:02 INFO - 'MAIL': '/var/mail/cltbld', 16:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:02 INFO - 'MOZ_NO_REMOTE': '1', 16:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:02 INFO - 'NO_EM_RESTART': '1', 16:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:02 INFO - 'PWD': '/builds/slave/test', 16:53:02 INFO - 'SHELL': '/bin/bash', 16:53:02 INFO - 'SHLVL': '1', 16:53:02 INFO - 'TERM': 'linux', 16:53:02 INFO - 'TMOUT': '86400', 16:53:02 INFO - 'USER': 'cltbld', 16:53:02 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:02 INFO - '_': '/tools/buildbot/bin/python'} 16:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:03 INFO - Running setup.py (path:/tmp/pip-rGhQyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:03 INFO - Running setup.py (path:/tmp/pip-vonbGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:03 INFO - Running setup.py (path:/tmp/pip-9Df1yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:03 INFO - Running setup.py (path:/tmp/pip-p6gCis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:03 INFO - Running setup.py (path:/tmp/pip-H5Nak2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:03 INFO - Running setup.py (path:/tmp/pip-zHZ5pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:03 INFO - Running setup.py (path:/tmp/pip-pH2jRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:03 INFO - Running setup.py (path:/tmp/pip-qu_kgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:03 INFO - Running setup.py (path:/tmp/pip-QxYm1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:03 INFO - Running setup.py (path:/tmp/pip-AiENQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:03 INFO - Running setup.py (path:/tmp/pip-95yuFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:03 INFO - Running setup.py (path:/tmp/pip-orZlrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:03 INFO - Running setup.py (path:/tmp/pip-sLvQVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:03 INFO - Running setup.py (path:/tmp/pip-KI4Qcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:04 INFO - Running setup.py (path:/tmp/pip-qMgFd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:04 INFO - Running setup.py (path:/tmp/pip-G6ZFyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:04 INFO - Running setup.py (path:/tmp/pip-uFfTSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:04 INFO - Running setup.py install for manifestparser 16:53:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:04 INFO - Running setup.py install for mozcrash 16:53:04 INFO - Running setup.py install for mozdebug 16:53:04 INFO - Running setup.py install for mozdevice 16:53:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:04 INFO - Running setup.py install for mozfile 16:53:04 INFO - Running setup.py install for mozhttpd 16:53:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:04 INFO - Running setup.py install for mozinfo 16:53:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:04 INFO - Running setup.py install for mozInstall 16:53:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozleak 16:53:05 INFO - Running setup.py install for mozlog 16:53:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for moznetwork 16:53:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozprocess 16:53:05 INFO - Running setup.py install for mozprofile 16:53:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozrunner 16:53:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Running setup.py install for mozscreenshot 16:53:05 INFO - Running setup.py install for moztest 16:53:05 INFO - Running setup.py install for mozversion 16:53:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:05 INFO - Cleaning up... 16:53:05 INFO - Return code: 0 16:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:05 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')]} 16:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:05 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')]} 16:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:06 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:53:06 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 16:53:06 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 16:53:06 INFO - Using env: {'DISPLAY': ':0', 16:53:06 INFO - 'HOME': '/home/cltbld', 16:53:06 INFO - 'LANG': 'en_US.UTF-8', 16:53:06 INFO - 'LANGUAGE': 'en_US:en', 16:53:06 INFO - 'LOGNAME': 'cltbld', 16:53:06 INFO - 'MAIL': '/var/mail/cltbld', 16:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:06 INFO - 'MOZ_NO_REMOTE': '1', 16:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:06 INFO - 'NO_EM_RESTART': '1', 16:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:06 INFO - 'PWD': '/builds/slave/test', 16:53:06 INFO - 'SHELL': '/bin/bash', 16:53:06 INFO - 'SHLVL': '1', 16:53:06 INFO - 'TERM': 'linux', 16:53:06 INFO - 'TMOUT': '86400', 16:53:06 INFO - 'USER': 'cltbld', 16:53:06 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:06 INFO - '_': '/tools/buildbot/bin/python'} 16:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:06 INFO - Running setup.py (path:/tmp/pip-co65Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:06 INFO - Running setup.py (path:/tmp/pip-WAQXDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:06 INFO - Running setup.py (path:/tmp/pip-jPuvyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:06 INFO - Running setup.py (path:/tmp/pip-47JEqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:06 INFO - Running setup.py (path:/tmp/pip-tBB65m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:06 INFO - Running setup.py (path:/tmp/pip-be8wcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:06 INFO - Running setup.py (path:/tmp/pip-L_3tvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:06 INFO - Running setup.py (path:/tmp/pip-Gwz78A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:06 INFO - Running setup.py (path:/tmp/pip-CXqxd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:06 INFO - Running setup.py (path:/tmp/pip-nsQejf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:06 INFO - Running setup.py (path:/tmp/pip-CsPZm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:06 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)) 16:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:06 INFO - Running setup.py (path:/tmp/pip-t83ce1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:07 INFO - Running setup.py (path:/tmp/pip-dIII_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:07 INFO - Running setup.py (path:/tmp/pip-jmQ_hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:07 INFO - Running setup.py (path:/tmp/pip-vQwObG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:07 INFO - Running setup.py (path:/tmp/pip-PN9WJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:07 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)) 16:53:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:07 INFO - Running setup.py (path:/tmp/pip-PHDwnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:07 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)) 16:53:07 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)) 16:53:07 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)) 16:53:07 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)) 16:53:07 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)) 16:53:07 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)) 16:53:07 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)) 16:53:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:07 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 16:53:07 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 16:53:07 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 16:53:07 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 16:53:08 INFO - Downloading blessings-1.6.tar.gz 16:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:08 INFO - Installing collected packages: blessings 16:53:08 INFO - Running setup.py install for blessings 16:53:08 INFO - Successfully installed blessings 16:53:08 INFO - Cleaning up... 16:53:08 INFO - Return code: 0 16:53:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:08 INFO - Reading from file tmpfile_stdout 16:53:08 INFO - Current package versions: 16:53:08 INFO - argparse == 1.2.1 16:53:08 INFO - blessings == 1.6 16:53:08 INFO - blobuploader == 1.2.4 16:53:08 INFO - docopt == 0.6.1 16:53:08 INFO - functools32 == 3.2.3-2 16:53:08 INFO - jsonschema == 2.5.1 16:53:08 INFO - manifestparser == 1.1 16:53:08 INFO - mozInstall == 1.13 16:53:08 INFO - mozcrash == 1.0 16:53:08 INFO - mozdebug == 0.1 16:53:08 INFO - mozdevice == 0.51 16:53:08 INFO - mozfile == 1.2 16:53:08 INFO - mozhttpd == 0.7 16:53:08 INFO - mozinfo == 0.10 16:53:08 INFO - mozleak == 0.1 16:53:08 INFO - mozlog == 3.5 16:53:08 INFO - moznetwork == 0.27 16:53:08 INFO - mozprocess == 0.25 16:53:08 INFO - mozprofile == 0.28 16:53:08 INFO - mozrunner == 6.13 16:53:08 INFO - mozscreenshot == 0.1 16:53:08 INFO - mozsystemmonitor == 0.3 16:53:08 INFO - moztest == 0.8 16:53:08 INFO - mozversion == 1.4 16:53:08 INFO - psutil == 3.1.1 16:53:08 INFO - requests == 1.2.3 16:53:08 INFO - wsgiref == 0.1.2 16:53:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:08 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')]} 16:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:08 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')]} 16:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:08 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:53:08 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 16:53:08 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 16:53:08 INFO - Using env: {'DISPLAY': ':0', 16:53:08 INFO - 'HOME': '/home/cltbld', 16:53:08 INFO - 'LANG': 'en_US.UTF-8', 16:53:08 INFO - 'LANGUAGE': 'en_US:en', 16:53:08 INFO - 'LOGNAME': 'cltbld', 16:53:08 INFO - 'MAIL': '/var/mail/cltbld', 16:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:08 INFO - 'MOZ_NO_REMOTE': '1', 16:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:08 INFO - 'NO_EM_RESTART': '1', 16:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:08 INFO - 'PWD': '/builds/slave/test', 16:53:08 INFO - 'SHELL': '/bin/bash', 16:53:08 INFO - 'SHLVL': '1', 16:53:08 INFO - 'TERM': 'linux', 16:53:08 INFO - 'TMOUT': '86400', 16:53:08 INFO - 'USER': 'cltbld', 16:53:08 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:08 INFO - '_': '/tools/buildbot/bin/python'} 16:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 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)) 16:53:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:53:09 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 16:53:09 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 16:53:09 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 16:53:09 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 16:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:53:10 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)) 16:53:10 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)) 16:53:10 INFO - Installing collected packages: simplejson 16:53:10 INFO - Running setup.py install for simplejson 16:53:10 INFO - building 'simplejson._speedups' extension 16:53:10 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 16:53:11 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 16:53:11 INFO - Successfully installed simplejson 16:53:11 INFO - Cleaning up... 16:53:11 INFO - Return code: 0 16:53:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:11 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')]} 16:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:11 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')]} 16:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:11 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 0x1c701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e38b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', '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 16:53:11 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 16:53:11 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 16:53:11 INFO - Using env: {'DISPLAY': ':0', 16:53:11 INFO - 'HOME': '/home/cltbld', 16:53:11 INFO - 'LANG': 'en_US.UTF-8', 16:53:11 INFO - 'LANGUAGE': 'en_US:en', 16:53:11 INFO - 'LOGNAME': 'cltbld', 16:53:11 INFO - 'MAIL': '/var/mail/cltbld', 16:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:11 INFO - 'MOZ_NO_REMOTE': '1', 16:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:11 INFO - 'NO_EM_RESTART': '1', 16:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:11 INFO - 'PWD': '/builds/slave/test', 16:53:11 INFO - 'SHELL': '/bin/bash', 16:53:11 INFO - 'SHLVL': '1', 16:53:11 INFO - 'TERM': 'linux', 16:53:11 INFO - 'TMOUT': '86400', 16:53:11 INFO - 'USER': 'cltbld', 16:53:11 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:11 INFO - '_': '/tools/buildbot/bin/python'} 16:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:53:11 INFO - Cleaning up... 16:53:11 INFO - Return code: 0 16:53:11 INFO - Running post-action listener: _resource_record_post_action 16:53:11 INFO - Running post-action listener: _start_resource_monitoring 16:53:11 INFO - Starting resource monitoring. 16:53:11 INFO - [mozharness: 2017-09-26 23:53:11.731446Z] Finished create-virtualenv step (success) 16:53:11 INFO - [mozharness: 2017-09-26 23:53:11.732393Z] Running install step. 16:53:11 INFO - Running pre-action listener: _resource_record_pre_action 16:53:11 INFO - Running main action method: install 16:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:11 INFO - Reading from file tmpfile_stdout 16:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:12 INFO - Reading from file tmpfile_stdout 16:53:12 INFO - Output received: 16:53:12 INFO - Usage: mozinstall [options] installer 16:53:12 INFO - Options: 16:53:12 INFO - -h, --help show this help message and exit 16:53:12 INFO - -d DEST, --destination=DEST 16:53:12 INFO - Directory to install application into. [default: 16:53:12 INFO - "/builds/slave/test"] 16:53:12 INFO - --app=APP Application being installed. [default: firefox] 16:53:12 INFO - mkdir: /builds/slave/test/build/application 16:53:12 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'] 16:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:53:30 INFO - Reading from file tmpfile_stdout 16:53:30 INFO - Output received: 16:53:30 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:30 INFO - Running post-action listener: _resource_record_post_action 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.565917Z] Finished install step (success) 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.566167Z] Running setup-mitmproxy step. 16:53:30 INFO - Running pre-action listener: _resource_record_pre_action 16:53:30 INFO - Running main action method: setup_mitmproxy 16:53:30 INFO - Skipping: mitmproxy is not required 16:53:30 INFO - Running post-action listener: _resource_record_post_action 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.567356Z] Finished setup-mitmproxy step (success) 16:53:30 INFO - [mozharness: 2017-09-26 23:53:30.567592Z] Running run-tests step. 16:53:30 INFO - Running pre-action listener: _resource_record_pre_action 16:53:30 INFO - Running pre-action listener: _set_gcov_prefix 16:53:30 INFO - Running main action method: run_tests 16:53:30 WARNING - Try message not found. 16:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:30 INFO - Python 2.7.3 16:53:30 INFO - Return code: 0 16:53:30 INFO - grabbing minidump binary from tooltool 16:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:30 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 0x1fdad60>, '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 0x1fdba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdbef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:30 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 16:53:30 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 16:53:30 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 16:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:30 INFO - Return code: 0 16:53:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:30 INFO - ENV: RUST_BACKTRACE is now full 16:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:53:30 INFO - Using env: {'DISPLAY': ':0', 16:53:30 INFO - 'HOME': '/home/cltbld', 16:53:30 INFO - 'LANG': 'en_US.UTF-8', 16:53:30 INFO - 'LANGUAGE': 'en_US:en', 16:53:30 INFO - 'LOGNAME': 'cltbld', 16:53:30 INFO - 'MAIL': '/var/mail/cltbld', 16:53:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:30 INFO - 'MOZ_NO_REMOTE': '1', 16:53:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:30 INFO - 'NO_EM_RESTART': '1', 16:53:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:30 INFO - 'PWD': '/builds/slave/test', 16:53:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:30 INFO - 'RUST_BACKTRACE': 'full', 16:53:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:53:30 INFO - 'SHELL': '/bin/bash', 16:53:30 INFO - 'SHLVL': '1', 16:53:30 INFO - 'TERM': 'linux', 16:53:30 INFO - 'TMOUT': '86400', 16:53:30 INFO - 'USER': 'cltbld', 16:53:30 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:30 INFO - '_': '/tools/buildbot/bin/python'} 16:53:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:53:30 INFO - mozversion application_buildid: 20170926225505 16:53:30 INFO - mozversion application_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 16:53:30 INFO - mozversion application_display_name: Nightly 16:53:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:30 INFO - mozversion application_name: Firefox 16:53:30 INFO - mozversion application_remotingname: firefox 16:53:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:53:30 INFO - mozversion application_vendor: Mozilla 16:53:30 INFO - mozversion application_version: 58.0a1 16:53:30 INFO - mozversion platform_buildid: 20170926225505 16:53:30 INFO - mozversion platform_changeset: b7d8ae4a03c62e549b9d82595b1d1964f0af70cd 16:53:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:53:30 INFO - mozversion platform_version: 58.0a1 16:53:30 INFO - using testdate: 1506470010 16:53:30 INFO - actual date: 1506470010 16:53:30 INFO - starting webserver on 'localhost:46657' 16:53:30 INFO - SUITE-START | Running 2 tests 16:53:30 INFO - TEST-START | dromaeo_css 16:53:30 INFO - Initialising browser for dromaeo_css test... 16:53:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46657/getInfo.html -profile /tmp/tmp1QlFLW/profile 16:53:30 INFO - TEST-INFO | started process 3600 (/builds/slave/test/build/application/firefox/firefox http://localhost:46657/getInfo.html) 16:53:38 INFO - TEST-INFO | 3600: exit 0 16:53:39 INFO - Browser initialized. 16:53:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:53:39 INFO - Using env: {'DISPLAY': ':0', 16:53:39 INFO - 'HOME': '/home/cltbld', 16:53:39 INFO - 'JSGC_DISABLE_POISONING': '1', 16:53:39 INFO - 'LANG': 'en_US.UTF-8', 16:53:39 INFO - 'LANGUAGE': 'en_US:en', 16:53:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:53:39 INFO - 'LOGNAME': 'cltbld', 16:53:39 INFO - 'MAIL': '/var/mail/cltbld', 16:53:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:39 INFO - 'MOZ_CRASHREPORTER': '1', 16:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:53:39 INFO - 'MOZ_NO_REMOTE': '1', 16:53:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:39 INFO - 'NO_EM_RESTART': '1', 16:53:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:39 INFO - 'PWD': '/builds/slave/test', 16:53:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:39 INFO - 'RUST_BACKTRACE': 'full', 16:53:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:53:39 INFO - 'SHELL': '/bin/bash', 16:53:39 INFO - 'SHLVL': '1', 16:53:39 INFO - 'STYLO_FORCE_DISABLED': '1', 16:53:39 INFO - 'TERM': 'linux', 16:53:39 INFO - 'TMOUT': '86400', 16:53:39 INFO - 'USER': 'cltbld', 16:53:39 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 16:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:39 INFO - '_': '/tools/buildbot/bin/python'} 16:53:39 INFO - TEST-INFO | started process 3834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1QlFLW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:39 INFO - PID 3834 | 16:53:39 INFO - PID 3834 | (/builds/slave/test/build/application/firefox/firefox:3883): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:53:39 INFO - PID 3834 | 16:53:50 INFO - PID 3834 | RSS: Main: 151449600 16:53:50 INFO - PID 3834 | 16:56:47 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:46657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46657/tests/dromaeo/cssquery-ext.html) 16:56:49 INFO - PID 3834 | RSS: Main: 152686592 16:56:49 INFO - PID 3834 | 16:59:50 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:46657/tests/dromaeo/cssquery-ext.html (next: http://localhost:46657/tests/dromaeo/cssquery-jquery.html) 16:59:51 INFO - PID 3834 | RSS: Main: 152420352 16:59:51 INFO - PID 3834 | 17:02:53 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:46657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46657/tests/dromaeo/cssquery-mootools.html) 17:02:53 INFO - PID 3834 | RSS: Main: 154279936 17:02:53 INFO - PID 3834 | 17:05:55 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:46657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46657/tests/dromaeo/cssquery-prototype.html) 17:05:56 INFO - PID 3834 | RSS: Main: 152436736 17:05:56 INFO - PID 3834 | 17:08:59 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:46657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46657/tests/dromaeo/cssquery-yui.html) 17:09:00 INFO - PID 3834 | RSS: Main: 154353664 17:09:00 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | Cycle 1(1): loaded http://localhost:46657/tests/dromaeo/cssquery-yui.html (next: http://localhost:46657/tests/dromaeo/cssquery-dojo.html) 17:12:01 INFO - PID 3834 | RSS: Main: 155508736 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | __start_tp_report 17:12:01 INFO - PID 3834 | _x_x_mozilla_page_load 17:12:01 INFO - PID 3834 | _x_x_mozilla_page_load_details 17:12:01 INFO - PID 3834 | |i|pagename|runs| 17:12:01 INFO - PID 3834 | |0;dojo.html;3124.85938132784;3132.577102091217;3166.667499912509;3173.8889138880145;3188.569543111679;6203.441690247877;6317.810465686025;6380.968095159524;6394.872102557946;6521.576097553661;6324.841878953029;6345.175127233453;6376.330485299035;6406.231252249737;6419.32597077306;5861.501772349356;5901.173835662989;5968.985272503684;5974.79088231912;6025.638461692312;5858.76564937402;5939.198208241875;5990.550708696844;6009.1587177795145;6028.819135425944;5742.253507044099;5828.271466066742;5842.152887831241;5873.647581145124;5974.761009559613;5881.382454842265;5882.764689412418;5897.852553686149;5939.821805345847;5956.255468066492;5764.394738552433;5823.068309070571;5896.557758168155;5905.114232865061;5918.556108291896;6297.4962003039645;6316.399942005548;6378.93621063788;6422.775202867877;6427.485801135898;6878.3465570770695;6888.380045795902;6891.931080689179;6899.137607799025;6932.618705971169;6893.827654308632;6998.895016574756;7003.369696727319;7009.299070093001;7014.649267536603;6196;6345.270293916213;6393.136926514908;6467.029945508164;6474.935250647481;6963.199232088375;7014.92985070153;7053.506254562234;7055.541389809646;7059.117610298713;6690;6693.866122677519;6704.396604305538;6709.798706038827;6710.16122984627;6873.553219040747;6906;6920.411764999931;6923.446124310043;6931.306869313129;6829.282925292872;6855.965720171367;6872.381485666314;6907.620080895498;6915.585064896122;6704.497162712816;6832.897506537406;6842.794716158423;6868.175818901764;6974.825629359205;5398.4871437213405;5405;5409.83770486886;5415.783368665288;5417.024935511567;4662.114198302312;4727.739974301447;4774.116788394158;4781.330613714083;4806.086843499794;5856.267966504187;5860.501857342088;5926.199963005025;5934.643921364732;5943.732532036069;6741.393274605309;6832.487563432763;6842.247352791189;6902.689378977958;6957.8956315655305;5842.620229685057;5884.499817515473;5901.881962360814;5928.7332070056955;5933.554983376264;5844.12338149281;5850.5612079094235;5924.407559244041;5936.673482958392;5940.108983652487;6434.7104380303;6518.152640156749;6583.670816459158;6590.011498275297;6628.337166283333;6929.930700692928;6948.583085014915;6963.860722785617;6966.79099627012;6974.860502790018;6557.9344206557325;6558.049082883051;6605.108310378229;6665.866682666417;6675.766348177791;6750.493712971449;6784.118064651564;6799.796006119825;6813;6868.347506986828;6880.449564034965;6939.410150137295;6966.233714291525;6985.0220969065385;6989.545679530815;6647.302033286629;6663.233728121328;6748.527603067738;6750.35871592198;6751.797446076625;6497.4477169441125;6589.934100659124;6646.368594983469;6731.394174524316;6732.966335168293;6487.54587178893;6494.545381823227;6496.252930913006;6496.610203387811;6497.480201583768;6490.967545162244;6639.800805975829;6645;6650.20197576294;6689.163854518185;6327.019312006646;6455.193100862392;6484.578502397329;6548.639824809681;6588.209414870054 17:12:01 INFO - PID 3834 | |1;ext.html;845.7293666026874;872.4329186029081;893.7854914820444;898.5956319656157;899.9685011024613;37051.81474092629;39348;39386.2122757545;39510.60489395105;39600.40599391011;36202.63797362026;36248.09379765507;36256.274874502495;36371.63628363722;36583.63416365842;7088.929110708891;7283.198848126702;7322.304381083789;7328.523645963022;7328.926710732878;7066.964665176667;7189.424846012333;7195.8201044973775;7213.567185968833;7215.855682886366;7905.723299684512;8087.919120808805;8090.797730056766;8090.838183236332;8093.959530202341;7994.080680721704;8053.395995300347;8060.516369017849;8063.3952453565635;8072.798180045487;7724.922750772476;7748.845023099507;7842.098158711764;7941.523508589503;7970;37019.629803701886;37040.444393334124;37082.629173708185;37234.627653723655;37300.62699372999;3454.1537323355687;3490.424080026818;3494.021673931303;3503.334366470388;3504.1414853360834;30378.84810575955;30446.69553304483;30536.69463305361;30575;30594.84702576495;5177.818776342848;5193.506616871391;5194.6883187008525;5208.427073021964;5229.163333866563;181375;182031;182329;182602;183462;46039.309410358874;46146.76926615345;46250.30624540635;46354.30468542974;46439.76780116078;48943.755281224076;49116;49138.508614914106;49144.50855491399;49191;13878.861211387959;14201.644958876112;14231.573052808433;14238.074525156038;14240.715185696228;11668.066554675606;11676.70808229784;11689.415529223505;11760.941195293968;11771.470283837249;14025.649358766112;14206.07660502064;14230.430782768573;14325.35535900887;14390.712185756227;5657.717114144276;5678.290213723285;5693.4875861172695;5700.37295897451;5959.539912721411;1000.7898341348398;1018.1956254558816;1022.3201570955232;1027.4811220333684;1038.7039693687263;22763.658545121838;22866.970986305656;22931.197408090637;22958.65562016571;23274.8836255821;1099.8460215569826;1105.4859490337033;1115.6597237842373;1121.388843080523;1134.0417347341483;11987.820182697267;12010.819837702442;12053.337066461429;12123.696907577381;12218.816717749241;211572;213871;213977;214248;214656;51811.48188518066;52632;53362.7331863346;53548.464515354346;53811.73094134504;1400.9019368644301;1437.856214378554;1443.1846007006009;1453.840077591464;1456.6795305032877;26145.084922027636;26393.340166495993;26449.735502644726;26976.460470790866;27089.1873243803;36752.816235918646;36859;36861.07847303839;36961;36961;185875;187306;187582;187826;188405;33285.50071748877;33298.833505832314;33369.83315083506;33626.159346015564;33684;39929.60070399259;40654.79672601618;40697.59302406938;40991.590084098774;41413;30188.69811301859;30263;30826.69173308328;30830.229244269074;31732.682673172974;30307.545386818776;30329.545056824605;30601.08196754101;30648.778494322993;30649.233769155057;34658.133546661535;34848;34856.12859678528;35017.649823502456;35018.474722879684;30277;30390;30438.086857394315;30519.23701907381;30806.537901931042;22713.772862271828;23149.42126446852;23192.536149277257;23431.531369372857;23562.646560301953 17:12:01 INFO - PID 3834 | |2;jquery.html;570.6747154122149;587.6239206907583;588.3904881848997;598.9191459153013;618.8731310081433;22059.33821985341;22864;22955.08179672811;22978.88510557449;22990.310290691305;20042.699359509617;21064.684029739565;21396.8930155349;21494;21623.6756448653;6480.611163330203;6623.867522649544;6633.535652504326;6633.767818126366;6650.5012124090645;6437.935620643804;6503.707333169995;6504.609723416586;6506.93493065068;6543.280239173687;6716.93283067168;6718.563293385914;6729.293424190439;6738.663066846662;6739.8652026959435;6713.731450741964;6719.529632925697;6726.159230096238;6731.192256929151;6731.899021514657;6070.696465176724;6276.372362763733;6291.1192433059405;6310.589811662273;6312.589681670676;28687.426251474855;29134;29224.41551168986;29230.85384573085;29271.121866344045;1948.2109745553073;2025.5037515808574;2031.9695204571942;2037.7554693436882;2044.31515442327;19135.330263440712;19595.314164004332;19674.40976770699;19763;19985.100670469863;2467.851928884255;2468.1731619907355;2499.187763976715;2504.6743923290037;2515.3585835611802;119994;125968;133171;134608;139730;14739.189344585937;14744.336504857307;14795.931118942162;15100.169490678118;15168.69931900741;23535;23548.64677029846;23593.0562777487;23616.40958976005;23654.64518032231;9840;9873.80252394948;9911.65309214174;9983;10059.849102263472;9046.773830654287;9115.225205857443;9144.177024067732;9202.079792020879;9247.583858726239;8957.387670219423;9010.549472526347;9172.174504294646;9192.402493837879;9204.493752843524;2717.293503689055;2734.179746076209;2847.601335812988;2889.1477014280417;2892.3203047283873;946.1720994130136;957.9521023948774;964.5563041001078;977.4965892565192;977.9511024448891;18536.81463185378;18979;19267.325643602406;19295.324663636704;19549.511262218275;1002.9147522460527;1008.4604736465956;1012.9088382045651;1018.8777346718441;1025.610268098118;10456.477176141163;10485.37087774736;10656.467176641292;10681.465926703633;10764.730881728019;465368;470734;472220;478159;488640;103063.4846825761;106531;106592.46703766432;108270;109890;1061.135174832509;1104.111190491662;1138.823482360219;1145.204083162211;1182.645206438065;20075.0966206524;20134.79865201329;20210.494737631678;20233.392998210078;20329.085191166138;57915.420845791006;60392;60422.69788651029;60545;61968.380316196264;72932;75056;75487;75871;77053;14343.426262949366;14374.640633984234;14525.78211326852;14662;14663.56009319722;22664.886675566515;22690.432739180993;22722.20472283462;22958;22969.540609188058;18082.909585451987;18198.090095494907;18423.355182568546;18486.81513184905;18632;15198.79617455485;15609.297581608627;15794.36822527086;15903.363865445715;15996.360145594512;17554.94670319785;18285;18673;18818.52953676169;18994.905025474785;14236.572902812932;14369.066010709688;14390.136591804525;14433.35049922735;14487.420503179756;17823.554411139827;17840.821591783915;18080.367187148386;18121.456356309332;18128.093595320446 17:12:01 INFO - PID 3834 | |3;mootools.html;1316.9473221071155;1375.566696490606;1379.1518216296975;1379.6757761925946;1384.6538365408642;15024.924875375622;16213.756793648075;16232.75650865238;16237.431689890842;16246.593835154097;15827.208639568003;16092.919535402336;16106.83893161068;16107.597310067225;16129.193540322965;2721.5781553859183;2776.569631707089;2776.6112744215825;2777.472280266753;2779.1523585306472;2697.2582539801515;2706.377533167373;2737.1651646247888;2737.4525094980986;2739.397332586828;2584.8578328191943;2679.370347968226;2679.450712603921;2743.1496236166854;2747.175847245828;2743.8353698778037;2775.4726601945667;2777.8749956251813;2779.1523585306472;2781.2629653141935;2474.0474917156844;2517.874106294678;2524.8106392020486;2533.9239822805343;2633.2890119667773;15006.624834379229;15136.848631513763;15138.772918406232;15147.166905820175;15160.696786064216;7912.327452166573;8147.592620369017;8150.3479721622125;8152.225538573826;8186.099529051799;5110.744462776846;5382.111951527993;5396.541293990015;5420.891582168374;5517;1916.8945707986056;1950.112698722078;1962.8429725621916;2018.929337473196;2029.4621925189836;25816.225513234443;25820.354491137685;25860.224193274233;25870.6119408209;25986.74013259881;6633.2703402625675;6658.600483970978;6680.532362734659;6839.521233513607;6849.1780986281965;16913.492595222164;16972.321107155574;16991;17015.14924253807;17027.404040858757;7189.676464559107;7300.6349682515665;7311.4516411268305;7332.156801967842;7335.193128755833;6673.099131617267;6810.795676129724;6836.623985680835;6915.965420172867;6923.757668481579;5119.360079990001;5197.064528384927;5260.868478288074;5291.920621190685;5319.361676598833;1500.482333594908;1502.6994601079828;1518.6507103366287;1522.5204060720837;1549.264099552726;871.4727589808075;893.6336102198068;902.9322800789967;909.2816674826813;915.9771005724776;7582.924170758332;7602.429817763579;7662.923370766221;7665.233476652402;7745.651445684957;722.8734971379987;726.8800647893144;727.2291371146496;733.043378391194;734.8530293941233;4742.430908291027;5060.84817455477;5193.714345710947;5458.972705136528;5471.4528547145765;21114.577708445744;22028.88985555062;22065.33803985883;22177.223797167022;22354.888225558767;20919;21886.45283867884;21945.890270548545;21993.560128797333;22026.11895524193;10514.106300964504;10624.468776561142;10639.042486176282;10647.627333043307;10651.360918344924;7728.601210960417;8070.192980702118;8112.22933821286;8171.509709417454;8187.385946053951;17934;18371.448856534324;18418;18533.98063106542;18949.810501895357;18924;18960.146793394608;19137.425877223148;19536.706949395488;19585.118669659616;10418.114460270659;10454.215933805148;10472.476376181314;10580.788384232119;10624.84062739044;13148.211107333591;13269.933650331686;13314.267715275366;13326.86673133295;13334.533291334757;10003.199744020607;10019.148372388428;10043.69868903934;10070.295079344376;10303.845442318221;10382.688519344432;10467.371957682564;10572.577096916037;10730.302530335503;10799.73000674958;8931.062238464867;9024.142706442877;9121.543922803967;9124.31567632417;9153.130452606993;6916.619585922823;7114.928850711427;7145.571265724073;7176.007680407508;7279.490435669452;7264.527805692613;7369.8157546061775;7387.9261207387235;7391.334779869838;7542.170361260367 17:12:01 INFO - PID 3834 | |4;prototype.html;513.4967731623008;523.6884053987878;548.0737553534526;553.3553410277027;560.2324815003445;6172.783952561661;6234.781782637609;6311.936880631192;6346.365363463651;6395.840103997402;6271.184745983027;6272.4041216084515;6317.494600431966;6325.588836725621;6344.048392741091;5195.467337135535;5212.139996900507;5229.712365819897;5282;5301.284326615906;4946.9752651236695;5097.643164978453;5135.152699804527;5245.475452454743;5247.501487358714;5047.570956468686;5067.467915868836;5095.210242412432;5104.5405913467785;5141.537261646451;5051.166557518023;5067.771950262247;5068.543831055223;5076.289319495274;5111.6166287528395;4605.769711514411;4616.799632095645;4620.422447194101;4623.514530974233;4668.409032986691;6172.598781079216;6269.843253918643;6271.278802937675;6333.321669757518;6351.142595749607;5715.857103572403;5775.624584402;5803.7968671096305;5847;5855.3851845556455;6649.335066493312;6649.800505984828;6692.966535167293;6693.832654183636;6716.3283671632935;4943.283223932545;5005.698518385246;5006.74966251686;5039.622028347889;5043.445221025684;6926.965365173141;6999.265077166875;7008.299170083002;7078.292170782932;7085.362317391408;5087.26234695967;5091.796328146833;5097.796088156432;5098.337216161949;5120.436751957282;5198.81804136861;5202.323697919322;5225.23062776729;5226.764795584208;5227.163653815372;5803.738831752581;5813.854653633693;5832.88334233313;5845.749386486148;5861.824145275648;6309.305976342599;6678.365555272241;6699.832504187337;6722.294159113223;6778.694958726869;1670.3485640600175;1703.49746824687;1706.5904182995992;1746.7379893015896;1787.1153778879539;1217.7578869553006;1223.6696092055095;1227.2391117507202;1243.2966835435511;1248.1949142803023;5654.9151762723595;5673.659580425187;5719.342275638355;5744;5751.338596061507;6454.870902581922;6731.831704207434;6753.932460675429;6780.897921644306;6796.878515044962;5630.73308505583;5666.150077488327;5737.426257374229;5752.712364381764;5775.971120144372;3534.8586056557965;3542.98228508861;3561.8753343632848;3597.6582224688614;3617.3850445423814;6461.544613047012;6554.63949482783;6556.836079097965;6597.637129957899;6612.23959244693;6907.240203577602;6909.894416893273;6912.827179320457;6933;6948.652567371611;6540.738370465128;6557.836054098686;6590.209174899042;6596.274409814917;6628.602283862983;6753.696083676345;6786.8642627148165;6794.641071785564;6850.725970961105;6875.690593923386;6729.73081076771;6730.990351447322;6746.8650626988165;6838.93161068383;6842.623655698984;6405.558749281561;6445.967770161119;6498.090267362479;6548;6579.671016449254;5003.824866129668;5018.172001619692;5050.646454748133;5067.493250674903;5092.821751238689;6429.5499315049365;6617.602943823386;6877.277885821916;6888.311168883071;6903.1716194055025;6232.626042437469;6428.164338635947;6506.909218121355;6583.65035167799;6588.934110658832;6391.201099862517;6421.683554871333;6505;6563.638999855054;6617.404433600999;6333.80143027768;6391.936080639134;6425.839354016187;6434.742610295536;6553.803385898431;6452.419282264619;6591.736330546724;6599.934000659932;6625.635590042594;6644.302348253364;6244.812655620339;6314.179156709598;6355.237371515448;6388.137601423934;6411.006294024433 17:12:01 INFO - PID 3834 | |5;yui.html;926.6849271247777;931.3154831199067;936.1901954809092;941.4586612697697;949.6771097826737;16717.331306747732;17077;17077.658446831058;17105.144742762874;17109.144542772858;15365.154916479589;17300.653986920253;17446.738298925527;17448.38930637428;17467.039312837787;969.2343048991288;986.7434467038586;989.5052473763119;989.7773001074737;990.3067852503241;946.820104180207;975.2539307429822;977.6871401151634;982.0670363154995;989.2036910287252;1035.4512108582426;1039.230969082877;1040.3445829127677;1041.3803786746873;1041.5052849896315;1024.109025148122;1024.6260115057987;1025.933314334566;1035.3735989726183;1036.6682661548307;755.3088923634867;756.7124492692797;757.8257000889771;757.8673732096917;758.0751483190498;16694.165291735364;16747;16750.246238919277;16768.748468772857;16792.832071679248;21351.359459216248;22037;22260.666090008664;22266.88866555673;22277.554448911094;15975.76036359444;17182.484525464257;17309.307627694878;17380.130993450275;17390.47828565145;3744.4944932434046;3750.9437358439645;3769.5288088988877;3770.3401904666575;3857.5370955485523;134237;134617;138602;139597;140102;15598.53204403847;15910.602234943988;15987.280572374271;16103.436379726654;16111;24761.752382475945;24810.5037899241;24814.627780583305;24855.62716559253;24936.376590585016;9045.954770226106;9133;9145.268378529701;9236.307276954256;9250.583723732449;4442.4669039715445;4557.1797076526545;4561.840335588238;4565.885852853705;4567.931481027787;5451.3458384994055;5508.283923089973;5527.972360138254;5548.4174161712435;5557.083081291542;1005.6429967361628;1005.9497025148713;1008.1178968402647;1015.9136473399695;1023.150784848574;694.354250546986;707.5754547271596;714.5177005521252;724.6557885004686;736.576468530597;11595.594154204562;11765.352465937529;12358.196717213352;12992.285424301564;13308.800367994489;687.5290426058166;700.2332445971653;703.8486725353971;713.4862898712919;719.9352058314777;5550.045602475987;5595.608307418442;5648.6893220872425;5682.971585142048;5763.394843541368;125998;126437.36781316035;126979;128614;128821;107554;110354.44822775834;111398.44300778444;112544.4372778131;114607.42696286632;91193;91504;92741.99999999865;94970;95935.52032239933;10452.007059329351;10460;10503.474826258504;10597.099246564128;10831.404272764757;43441.78279108584;44100.45648402291;44562.55437445584;45166.548334516236;45887.31169032534;55838.72080639571;57217.427825721206;57636.71181644065;58911.11633325418;59143;14890.85109148938;14896.255187240811;14947.925260373628;15029.774553381927;15069.924650376677;17365;17442.825571744626;17482.30070797205;17576.56058598545;17711.46865594034;13418.530351437652;13720.725585488035;13737.313134343043;13765.931170344084;13775.793363099361;13939.233342166279;13993.090449120775;14024.649383765487;14057.086289391156;14080.859191407955;14544.27278636085;14722.926385368004;14826.62933426673;15037.548873533811;15281.46514871974;11343.319400835977;11488.827667584826;11641.53433862636;11741.17811753169;11760.235584686969;12309.876901231231;12330.445129969352;12427.192232504858;12501.24992500453;12682.239065656091 17:12:01 INFO - PID 3834 | __end_tp_report 17:12:01 INFO - PID 3834 | __start_cc_report 17:12:01 INFO - PID 3834 | _x_x_mozilla_cycle_collect,298 17:12:01 INFO - PID 3834 | __end_cc_report 17:12:01 INFO - PID 3834 | __startTimestamp1506471121900__endTimestamp 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | ------- Summary: start ------- 17:12:01 INFO - PID 3834 | Number of tests: 6 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | [#0] dojo.html Cycles:165 Average:6301.92 Median:6496.61 stddev:761.33 (11.7%) stddev-sans-first:721.72 17:12:01 INFO - PID 3834 | Values: 3124.9 3132.6 3166.7 3173.9 3188.6 6203.4 6317.8 6381.0 6394.9 6521.6 6324.8 6345.2 6376.3 6406.2 6419.3 5861.5 5901.2 5969.0 5974.8 6025.6 5858.8 5939.2 5990.6 6009.2 6028.8 5742.3 5828.3 5842.2 5873.6 5974.8 5881.4 5882.8 5897.9 5939.8 5956.3 5764.4 5823.1 5896.6 5905.1 5918.6 6297.5 6316.4 6378.9 6422.8 6427.5 6878.3 6888.4 6891.9 6899.1 6932.6 6893.8 6998.9 7003.4 7009.3 7014.6 6196.0 6345.3 6393.1 6467.0 6474.9 6963.2 7014.9 7053.5 7055.5 7059.1 6690.0 6693.9 6704.4 6709.8 6710.2 6873.6 6906.0 6920.4 6923.4 6931.3 6829.3 6856.0 6872.4 6907.6 6915.6 6704.5 6832.9 6842.8 6868.2 6974.8 5398.5 5405.0 5409.8 5415.8 5417.0 4662.1 4727.7 4774.1 4781.3 4806.1 5856.3 5860.5 5926.2 5934.6 5943.7 6741.4 6832.5 6842.2 6902.7 6957.9 5842.6 5884.5 5901.9 5928.7 5933.6 5844.1 5850.6 5924.4 5936.7 5940.1 6434.7 6518.2 6583.7 6590.0 6628.3 6929.9 6948.6 6963.9 6966.8 6974.9 6557.9 6558.0 6605.1 6665.9 6675.8 6750.5 6784.1 6799.8 6813.0 6868.3 6880.4 6939.4 6966.2 6985.0 6989.5 6647.3 6663.2 6748.5 6750.4 6751.8 6497.4 6589.9 6646.4 6731.4 6733.0 6487.5 6494.5 6496.3 6496.6 6497.5 6491.0 6639.8 6645.0 6650.2 6689.2 6327.0 6455.2 6484.6 6548.6 6588.2 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | [#1] ext.html Cycles:180 Average:35964.44 Median:19056.14 stddev:50410.03 (264.5%) stddev-sans-first:50482.47 17:12:01 INFO - PID 3834 | Values: 845.7 872.4 893.8 898.6 900.0 37051.8 39348.0 39386.2 39510.6 39600.4 36202.6 36248.1 36256.3 36371.6 36583.6 7088.9 7283.2 7322.3 7328.5 7328.9 7067.0 7189.4 7195.8 7213.6 7215.9 7905.7 8087.9 8090.8 8090.8 8094.0 7994.1 8053.4 8060.5 8063.4 8072.8 7724.9 7748.8 7842.1 7941.5 7970.0 37019.6 37040.4 37082.6 37234.6 37300.6 3454.2 3490.4 3494.0 3503.3 3504.1 30378.8 30446.7 30536.7 30575.0 30594.8 5177.8 5193.5 5194.7 5208.4 5229.2 181375.0 182031.0 182329.0 182602.0 183462.0 46039.3 46146.8 46250.3 46354.3 46439.8 48943.8 49116.0 49138.5 49144.5 49191.0 13878.9 14201.6 14231.6 14238.1 14240.7 11668.1 11676.7 11689.4 11760.9 11771.5 14025.6 14206.1 14230.4 14325.4 14390.7 5657.7 5678.3 5693.5 5700.4 5959.5 1000.8 1018.2 1022.3 1027.5 1038.7 22763.7 22867.0 22931.2 22958.7 23274.9 1099.8 1105.5 1115.7 1121.4 1134.0 11987.8 12010.8 12053.3 12123.7 12218.8 211572.0 213871.0 213977.0 214248.0 214656.0 51811.5 52632.0 53362.7 53548.5 53811.7 1400.9 1437.9 1443.2 1453.8 1456.7 26145.1 26393.3 26449.7 26976.5 27089.2 36752.8 36859.0 36861.1 36961.0 36961.0 185875.0 187306.0 187582.0 187826.0 188405.0 33285.5 33298.8 33369.8 33626.2 33684.0 39929.6 40654.8 40697.6 40991.6 41413.0 30188.7 30263.0 30826.7 30830.2 31732.7 30307.5 30329.5 30601.1 30648.8 30649.2 34658.1 34848.0 34856.1 35017.6 35018.5 30277.0 30390.0 30438.1 30519.2 30806.5 22713.8 23149.4 23192.5 23431.5 23562.6 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | [#2] jquery.html Cycles:180 Average:33984.22 Median:22909.54 stddev:79898.95 (348.8%) stddev-sans-first:80083.71 17:12:01 INFO - PID 3834 | Values: 570.7 587.6 588.4 598.9 618.9 22059.3 22864.0 22955.1 22978.9 22990.3 20042.7 21064.7 21396.9 21494.0 21623.7 6480.6 6623.9 6633.5 6633.8 6650.5 6437.9 6503.7 6504.6 6506.9 6543.3 6716.9 6718.6 6729.3 6738.7 6739.9 6713.7 6719.5 6726.2 6731.2 6731.9 6070.7 6276.4 6291.1 6310.6 6312.6 28687.4 29134.0 29224.4 29230.9 29271.1 1948.2 2025.5 2032.0 2037.8 2044.3 19135.3 19595.3 19674.4 19763.0 19985.1 2467.9 2468.2 2499.2 2504.7 2515.4 119994.0 125968.0 133171.0 134608.0 139730.0 14739.2 14744.3 14795.9 15100.2 15168.7 23535.0 23548.6 23593.1 23616.4 23654.6 9840.0 9873.8 9911.7 9983.0 10059.8 9046.8 9115.2 9144.2 9202.1 9247.6 8957.4 9010.5 9172.2 9192.4 9204.5 2717.3 2734.2 2847.6 2889.1 2892.3 946.2 958.0 964.6 977.5 978.0 18536.8 18979.0 19267.3 19295.3 19549.5 1002.9 1008.5 1012.9 1018.9 1025.6 10456.5 10485.4 10656.5 10681.5 10764.7 465368.0 470734.0 472220.0 478159.0 488640.0 103063.5 106531.0 106592.5 108270.0 109890.0 1061.1 1104.1 1138.8 1145.2 1182.6 20075.1 20134.8 20210.5 20233.4 20329.1 57915.4 60392.0 60422.7 60545.0 61968.4 72932.0 75056.0 75487.0 75871.0 77053.0 14343.4 14374.6 14525.8 14662.0 14663.6 22664.9 22690.4 22722.2 22958.0 22969.5 18082.9 18198.1 18423.4 18486.8 18632.0 15198.8 15609.3 15794.4 15903.4 15996.4 17554.9 18285.0 18673.0 18818.5 18994.9 14236.6 14369.1 14390.1 14433.4 14487.4 17823.6 17840.8 18080.4 18121.5 18128.1 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | [#3] mootools.html Cycles:180 Average:9180.47 Median:2656.33 stddev:6676.61 (251.3%) stddev-sans-first:6669.20 17:12:01 INFO - PID 3834 | Values: 1316.9 1375.6 1379.2 1379.7 1384.7 15024.9 16213.8 16232.8 16237.4 16246.6 15827.2 16092.9 16106.8 16107.6 16129.2 2721.6 2776.6 2776.6 2777.5 2779.2 2697.3 2706.4 2737.2 2737.5 2739.4 2584.9 2679.4 2679.5 2743.1 2747.2 2743.8 2775.5 2777.9 2779.2 2781.3 2474.0 2517.9 2524.8 2533.9 2633.3 15006.6 15136.8 15138.8 15147.2 15160.7 7912.3 8147.6 8150.3 8152.2 8186.1 5110.7 5382.1 5396.5 5420.9 5517.0 1916.9 1950.1 1962.8 2018.9 2029.5 25816.2 25820.4 25860.2 25870.6 25986.7 6633.3 6658.6 6680.5 6839.5 6849.2 16913.5 16972.3 16991.0 17015.1 17027.4 7189.7 7300.6 7311.5 7332.2 7335.2 6673.1 6810.8 6836.6 6916.0 6923.8 5119.4 5197.1 5260.9 5291.9 5319.4 1500.5 1502.7 1518.7 1522.5 1549.3 871.5 893.6 902.9 909.3 916.0 7582.9 7602.4 7662.9 7665.2 7745.7 722.9 726.9 727.2 733.0 734.9 4742.4 5060.8 5193.7 5459.0 5471.5 21114.6 22028.9 22065.3 22177.2 22354.9 20919.0 21886.5 21945.9 21993.6 22026.1 10514.1 10624.5 10639.0 10647.6 10651.4 7728.6 8070.2 8112.2 8171.5 8187.4 17934.0 18371.4 18418.0 18534.0 18949.8 18924.0 18960.1 19137.4 19536.7 19585.1 10418.1 10454.2 10472.5 10580.8 10624.8 13148.2 13269.9 13314.3 13326.9 13334.5 10003.2 10019.1 10043.7 10070.3 10303.8 10382.7 10467.4 10572.6 10730.3 10799.7 8931.1 9024.1 9121.5 9124.3 9153.1 6916.6 7114.9 7145.6 7176.0 7279.5 7264.5 7369.8 7387.9 7391.3 7542.2 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | [#4] prototype.html Cycles:180 Average:5577.53 Median:6270.51 stddev:1552.32 (24.8%) stddev-sans-first:1509.42 17:12:01 INFO - PID 3834 | Values: 513.5 523.7 548.1 553.4 560.2 6172.8 6234.8 6311.9 6346.4 6395.8 6271.2 6272.4 6317.5 6325.6 6344.0 5195.5 5212.1 5229.7 5282.0 5301.3 4947.0 5097.6 5135.2 5245.5 5247.5 5047.6 5067.5 5095.2 5104.5 5141.5 5051.2 5067.8 5068.5 5076.3 5111.6 4605.8 4616.8 4620.4 4623.5 4668.4 6172.6 6269.8 6271.3 6333.3 6351.1 5715.9 5775.6 5803.8 5847.0 5855.4 6649.3 6649.8 6693.0 6693.8 6716.3 4943.3 5005.7 5006.7 5039.6 5043.4 6927.0 6999.3 7008.3 7078.3 7085.4 5087.3 5091.8 5097.8 5098.3 5120.4 5198.8 5202.3 5225.2 5226.8 5227.2 5803.7 5813.9 5832.9 5845.7 5861.8 6309.3 6678.4 6699.8 6722.3 6778.7 1670.3 1703.5 1706.6 1746.7 1787.1 1217.8 1223.7 1227.2 1243.3 1248.2 5654.9 5673.7 5719.3 5744.0 5751.3 6454.9 6731.8 6753.9 6780.9 6796.9 5630.7 5666.2 5737.4 5752.7 5776.0 3534.9 3543.0 3561.9 3597.7 3617.4 6461.5 6554.6 6556.8 6597.6 6612.2 6907.2 6909.9 6912.8 6933.0 6948.7 6540.7 6557.8 6590.2 6596.3 6628.6 6753.7 6786.9 6794.6 6850.7 6875.7 6729.7 6731.0 6746.9 6838.9 6842.6 6405.6 6446.0 6498.1 6548.0 6579.7 5003.8 5018.2 5050.6 5067.5 5092.8 6429.5 6617.6 6877.3 6888.3 6903.2 6232.6 6428.2 6506.9 6583.7 6588.9 6391.2 6421.7 6505.0 6563.6 6617.4 6333.8 6391.9 6425.8 6434.7 6553.8 6452.4 6591.7 6599.9 6625.6 6644.3 6244.8 6314.2 6355.2 6388.1 6411.0 17:12:01 INFO - PID 3834 | 17:12:01 INFO - PID 3834 | [#5] yui.html Cycles:180 Average:23924.10 Median:17372.57 stddev:35581.46 (204.8%) stddev-sans-first:35639.38 17:12:01 INFO - PID 3834 | Values: 926.7 931.3 936.2 941.5 949.7 16717.3 17077.0 17077.7 17105.1 17109.1 15365.2 17300.7 17446.7 17448.4 17467.0 969.2 986.7 989.5 989.8 990.3 946.8 975.3 977.7 982.1 989.2 1035.5 1039.2 1040.3 1041.4 1041.5 1024.1 1024.6 1025.9 1035.4 1036.7 755.3 756.7 757.8 757.9 758.1 16694.2 16747.0 16750.2 16768.7 16792.8 21351.4 22037.0 22260.7 22266.9 22277.6 15975.8 17182.5 17309.3 17380.1 17390.5 3744.5 3750.9 3769.5 3770.3 3857.5 134237.0 134617.0 138602.0 139597.0 140102.0 15598.5 15910.6 15987.3 16103.4 16111.0 24761.8 24810.5 24814.6 24855.6 24936.4 9046.0 9133.0 9145.3 9236.3 9250.6 4442.5 4557.2 4561.8 4565.9 4567.9 5451.3 5508.3 5528.0 5548.4 5557.1 1005.6 1005.9 1008.1 1015.9 1023.2 694.4 707.6 714.5 724.7 736.6 11595.6 11765.4 12358.2 12992.3 13308.8 687.5 700.2 703.8 713.5 719.9 5550.0 5595.6 5648.7 5683.0 5763.4 125998.0 126437.4 126979.0 128614.0 128821.0 107554.0 110354.4 111398.4 112544.4 114607.4 91193.0 91504.0 92742.0 94970.0 95935.5 10452.0 10460.0 10503.5 10597.1 10831.4 43441.8 44100.5 44562.6 45166.5 45887.3 55838.7 57217.4 57636.7 58911.1 59143.0 14890.9 14896.3 14947.9 15029.8 15069.9 17365.0 17442.8 17482.3 17576.6 17711.5 13418.5 13720.7 13737.3 13765.9 13775.8 13939.2 13993.1 14024.6 14057.1 14080.9 14544.3 14722.9 14826.6 15037.5 15281.5 11343.3 11488.8 11641.5 11741.2 11760.2 12309.9 12330.4 12427.2 12501.2 12682.2 17:12:01 INFO - PID 3834 | -------- Summary: end -------- 17:12:01 INFO - PID 3834 | 17:12:02 INFO - TEST-INFO | 3834: exit 0 17:12:02 INFO - TEST-OK | dromaeo_css | took 1111578ms 17:12:02 INFO - TEST-START | kraken 17:12:02 INFO - Initialising browser for kraken test... 17:12:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46657/getInfo.html -profile /tmp/tmptFSEE0/profile 17:12:02 INFO - TEST-INFO | started process 4203 (/builds/slave/test/build/application/firefox/firefox http://localhost:46657/getInfo.html) 17:12:08 INFO - TEST-INFO | 4203: exit 0 17:12:08 INFO - Browser initialized. 17:12:08 INFO - Running cycle 1/1 for kraken test... 17:12:08 INFO - Using env: {'DISPLAY': ':0', 17:12:08 INFO - 'HOME': '/home/cltbld', 17:12:08 INFO - 'JSGC_DISABLE_POISONING': '1', 17:12:08 INFO - 'LANG': 'en_US.UTF-8', 17:12:08 INFO - 'LANGUAGE': 'en_US:en', 17:12:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:12:08 INFO - 'LOGNAME': 'cltbld', 17:12:08 INFO - 'MAIL': '/var/mail/cltbld', 17:12:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:08 INFO - 'MOZ_CRASHREPORTER': '1', 17:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:12:08 INFO - 'MOZ_NO_REMOTE': '1', 17:12:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:08 INFO - 'NO_EM_RESTART': '1', 17:12:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:08 INFO - 'PWD': '/builds/slave/test', 17:12:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:08 INFO - 'RUST_BACKTRACE': 'full', 17:12:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:12:08 INFO - 'SHELL': '/bin/bash', 17:12:08 INFO - 'SHLVL': '1', 17:12:08 INFO - 'STYLO_FORCE_DISABLED': '1', 17:12:08 INFO - 'TERM': 'linux', 17:12:08 INFO - 'TMOUT': '86400', 17:12:08 INFO - 'USER': 'cltbld', 17:12:08 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269', 17:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:08 INFO - '_': '/tools/buildbot/bin/python'} 17:12:08 INFO - TEST-INFO | started process 4439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptFSEE0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:09 INFO - PID 4439 | 17:12:09 INFO - PID 4439 | (/builds/slave/test/build/application/firefox/firefox:4488): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:12:09 INFO - PID 4439 | 17:12:19 INFO - PID 4439 | RSS: Main: 151633920 17:12:19 INFO - PID 4439 | 17:12:22 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46657/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:23 INFO - PID 4439 | RSS: Main: 157270016 17:12:23 INFO - PID 4439 | 17:12:25 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46657/tests/kraken/driver.html?testName=audio-dft) 17:12:26 INFO - PID 4439 | RSS: Main: 157511680 17:12:26 INFO - PID 4439 | 17:12:29 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46657/tests/kraken/driver.html?testName=audio-fft) 17:12:30 INFO - PID 4439 | RSS: Main: 154255360 17:12:30 INFO - PID 4439 | 17:12:32 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46657/tests/kraken/driver.html?testName=audio-oscillator) 17:12:32 INFO - PID 4439 | RSS: Main: 154771456 17:12:32 INFO - PID 4439 | 17:12:34 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:12:35 INFO - PID 4439 | RSS: Main: 155254784 17:12:35 INFO - PID 4439 | 17:12:38 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46657/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:39 INFO - PID 4439 | RSS: Main: 157413376 17:12:39 INFO - PID 4439 | 17:12:42 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46657/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:43 INFO - PID 4439 | RSS: Main: 157753344 17:12:43 INFO - PID 4439 | 17:12:46 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46657/tests/kraken/driver.html?testName=json-parse-financial) 17:12:47 INFO - PID 4439 | RSS: Main: 157806592 17:12:47 INFO - PID 4439 | 17:12:48 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:49 INFO - PID 4439 | RSS: Main: 157884416 17:12:49 INFO - PID 4439 | 17:12:51 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:51 INFO - PID 4439 | RSS: Main: 157761536 17:12:51 INFO - PID 4439 | 17:12:54 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:54 INFO - PID 4439 | RSS: Main: 154898432 17:12:54 INFO - PID 4439 | 17:12:57 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:58 INFO - PID 4439 | RSS: Main: 155545600 17:12:58 INFO - PID 4439 | 17:13:00 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:01 INFO - PID 4439 | RSS: Main: 155504640 17:13:01 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | Cycle 1(1): loaded http://localhost:46657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46657/tests/kraken/driver.html?testName=ai-astar) 17:13:03 INFO - PID 4439 | RSS: Main: 156594176 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | __start_tp_report 17:13:03 INFO - PID 4439 | _x_x_mozilla_page_load 17:13:03 INFO - PID 4439 | _x_x_mozilla_page_load_details 17:13:03 INFO - PID 4439 | |i|pagename|runs| 17:13:03 INFO - PID 4439 | |0;ai-astar;108;106;107;107;107;95;110;108;109;108 17:13:03 INFO - PID 4439 | |1;audio-beat-detection;116;118;115;119;117;119;115;147;119;117 17:13:03 INFO - PID 4439 | |2;audio-dft;165;165;164;163;163;163;163;167;170;166 17:13:03 INFO - PID 4439 | |3;audio-fft;74;82;74;74;73;73;73;77;73;75 17:13:03 INFO - PID 4439 | |4;audio-oscillator;83;81;80;78;79;79;79;79;78;83 17:13:03 INFO - PID 4439 | |5;imaging-gaussian-blur;114;114;114;114;113;113;114;114;114;115 17:13:03 INFO - PID 4439 | |6;imaging-darkroom;152;147;148;147;150;148;151;148;150;148 17:13:03 INFO - PID 4439 | |7;imaging-desaturate;99;94;95;94;95;94;94;93;99;95 17:13:03 INFO - PID 4439 | |8;json-parse-financial;56;54;54;53;54;55;55;56;55;56 17:13:03 INFO - PID 4439 | |9;json-stringify-tinderbox;37;38;38;38;38;38;38;38;39;39 17:13:03 INFO - PID 4439 | |10;stanford-crypto-aes;73;73;75;73;74;88;73;74;72;71 17:13:03 INFO - PID 4439 | |11;stanford-crypto-ccm;110;112;113;111;117;111;115;113;111;116 17:13:03 INFO - PID 4439 | |12;stanford-crypto-pbkdf2;172;169;166;175;168;168;168;172;181;166 17:13:03 INFO - PID 4439 | |13;stanford-crypto-sha256-iterative;64;63;66;65;65;67;74;63;67;64 17:13:03 INFO - PID 4439 | __end_tp_report 17:13:03 INFO - PID 4439 | __start_cc_report 17:13:03 INFO - PID 4439 | _x_x_mozilla_cycle_collect,724 17:13:03 INFO - PID 4439 | __end_cc_report 17:13:03 INFO - PID 4439 | __startTimestamp1506471183620__endTimestamp 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | ------- Summary: start ------- 17:13:03 INFO - PID 4439 | Number of tests: 14 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#0] ai-astar Cycles:10 Average:106.50 Median:108.00 stddev:4.20 (3.9%) stddev-sans-first:4.42 17:13:03 INFO - PID 4439 | Values: 108.0 106.0 107.0 107.0 107.0 95.0 110.0 108.0 109.0 108.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:118.50 stddev:9.54 (8.1%) stddev-sans-first:10.00 17:13:03 INFO - PID 4439 | Values: 116.0 118.0 115.0 119.0 117.0 119.0 115.0 147.0 119.0 117.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.28 (1.4%) stddev-sans-first:2.42 17:13:03 INFO - PID 4439 | Values: 165.0 165.0 164.0 163.0 163.0 163.0 163.0 167.0 170.0 166.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.00 stddev:2.82 (3.8%) stddev-sans-first:2.98 17:13:03 INFO - PID 4439 | Values: 74.0 82.0 74.0 74.0 73.0 73.0 73.0 77.0 73.0 75.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:79.50 stddev:1.85 (2.3%) stddev-sans-first:1.59 17:13:03 INFO - PID 4439 | Values: 83.0 81.0 80.0 78.0 79.0 79.0 79.0 79.0 78.0 83.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:13:03 INFO - PID 4439 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 115.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.73 (1.2%) stddev-sans-first:1.42 17:13:03 INFO - PID 4439 | Values: 152.0 147.0 148.0 147.0 150.0 148.0 151.0 148.0 150.0 148.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:2.10 (2.2%) stddev-sans-first:1.72 17:13:03 INFO - PID 4439 | Values: 99.0 94.0 95.0 94.0 95.0 94.0 94.0 93.0 99.0 95.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 17:13:03 INFO - PID 4439 | Values: 56.0 54.0 54.0 53.0 54.0 55.0 55.0 56.0 55.0 56.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.44 17:13:03 INFO - PID 4439 | Values: 37.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 39.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:73.50 stddev:4.84 (6.6%) stddev-sans-first:5.09 17:13:03 INFO - PID 4439 | Values: 73.0 73.0 75.0 73.0 74.0 88.0 73.0 74.0 72.0 71.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#11] stanford-crypto-ccm Cycles:10 Average:112.90 Median:113.00 stddev:2.38 (2.1%) stddev-sans-first:2.28 17:13:03 INFO - PID 4439 | Values: 110.0 112.0 113.0 111.0 117.0 111.0 115.0 113.0 111.0 116.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.50 stddev:4.67 (2.7%) stddev-sans-first:4.92 17:13:03 INFO - PID 4439 | Values: 172.0 169.0 166.0 175.0 168.0 168.0 168.0 172.0 181.0 166.0 17:13:03 INFO - PID 4439 | 17:13:03 INFO - PID 4439 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:3.22 (4.9%) stddev-sans-first:3.35 17:13:03 INFO - PID 4439 | Values: 64.0 63.0 66.0 65.0 65.0 67.0 74.0 63.0 67.0 64.0 17:13:03 INFO - PID 4439 | -------- Summary: end -------- 17:13:03 INFO - PID 4439 | 17:13:04 INFO - PID 4439 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:13:04 INFO - TEST-INFO | 4439: exit 0 17:13:04 INFO - TEST-OK | kraken | took 61785ms 17:13:04 INFO - SUITE-END | took 1173s 17:13:04 INFO - Completed test suite (00:19:33) 17:13:04 INFO - javascript benchmark 17:13:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8449.473185215906, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.85938132784, 3132.577102091217, 3166.667499912509, 3173.8889138880145, 3188.569543111679, 6203.441690247877, 6317.810465686025, 6380.968095159524, 6394.872102557946, 6521.576097553661, 6324.841878953029, 6345.175127233453, 6376.330485299035, 6406.231252249737, 6419.32597077306, 5861.501772349356, 5901.173835662989, 5968.985272503684, 5974.79088231912, 6025.638461692312, 5858.76564937402, 5939.198208241875, 5990.550708696844, 6009.1587177795145, 6028.819135425944, 5742.253507044099, 5828.271466066742, 5842.152887831241, 5873.647581145124, 5974.761009559613, 5881.382454842265, 5882.764689412418, 5897.852553686149, 5939.821805345847, 5956.255468066492, 5764.394738552433, 5823.068309070571, 5896.557758168155, 5905.114232865061, 5918.556108291896, 6297.4962003039645, 6316.399942005548, 6378.93621063788, 6422.775202867877, 6427.485801135898, 6878.3465570770695, 6888.380045795902, 6891.931080689179, 6899.137607799025, 6932.618705971169, 6893.827654308632, 6998.895016574756, 7003.369696727319, 7009.299070093001, 7014.649267536603, 6196.0, 6345.270293916213, 6393.136926514908, 6467.029945508164, 6474.935250647481, 6963.199232088375, 7014.92985070153, 7053.506254562234, 7055.541389809646, 7059.117610298713, 6690.0, 6693.866122677519, 6704.396604305538, 6709.798706038827, 6710.16122984627, 6873.553219040747, 6906.0, 6920.411764999931, 6923.446124310043, 6931.306869313129, 6829.282925292872, 6855.965720171367, 6872.381485666314, 6907.620080895498, 6915.585064896122, 6704.497162712816, 6832.897506537406, 6842.794716158423, 6868.175818901764, 6974.825629359205, 5398.4871437213405, 5405.0, 5409.83770486886, 5415.783368665288, 5417.024935511567, 4662.114198302312, 4727.739974301447, 4774.116788394158, 4781.330613714083, 4806.086843499794, 5856.267966504187, 5860.501857342088, 5926.199963005025, 5934.643921364732, 5943.732532036069, 6741.393274605309, 6832.487563432763, 6842.247352791189, 6902.689378977958, 6957.8956315655305, 5842.620229685057, 5884.499817515473, 5901.881962360814, 5928.7332070056955, 5933.554983376264, 5844.12338149281, 5850.5612079094235, 5924.407559244041, 5936.673482958392, 5940.108983652487, 6434.7104380303, 6518.152640156749, 6583.670816459158, 6590.011498275297, 6628.337166283333, 6929.930700692928, 6948.583085014915, 6963.860722785617, 6966.79099627012, 6974.860502790018, 6557.9344206557325, 6558.049082883051, 6605.108310378229, 6665.866682666417, 6675.766348177791, 6750.493712971449, 6784.118064651564, 6799.796006119825, 6813.0, 6868.347506986828, 6880.449564034965, 6939.410150137295, 6966.233714291525, 6985.0220969065385, 6989.545679530815, 6647.302033286629, 6663.233728121328, 6748.527603067738, 6750.35871592198, 6751.797446076625, 6497.4477169441125, 6589.934100659124, 6646.368594983469, 6731.394174524316, 6732.966335168293, 6487.54587178893, 6494.545381823227, 6496.252930913006, 6496.610203387811, 6497.480201583768, 6490.967545162244, 6639.800805975829, 6645.0, 6650.20197576294, 6689.163854518185, 6327.019312006646, 6455.193100862392, 6484.578502397329, 6548.639824809681, 6588.209414870054], "value": 6242.938479634055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.7293666026874, 872.4329186029081, 893.7854914820444, 898.5956319656157, 899.9685011024613, 37051.81474092629, 39348.0, 39386.2122757545, 39510.60489395105, 39600.40599391011, 36202.63797362026, 36248.09379765507, 36256.274874502495, 36371.63628363722, 36583.63416365842, 7088.929110708891, 7283.198848126702, 7322.304381083789, 7328.523645963022, 7328.926710732878, 7066.964665176667, 7189.424846012333, 7195.8201044973775, 7213.567185968833, 7215.855682886366, 7905.723299684512, 8087.919120808805, 8090.797730056766, 8090.838183236332, 8093.959530202341, 7994.080680721704, 8053.395995300347, 8060.516369017849, 8063.3952453565635, 8072.798180045487, 7724.922750772476, 7748.845023099507, 7842.098158711764, 7941.523508589503, 7970.0, 37019.629803701886, 37040.444393334124, 37082.629173708185, 37234.627653723655, 37300.62699372999, 3454.1537323355687, 3490.424080026818, 3494.021673931303, 3503.334366470388, 3504.1414853360834, 30378.84810575955, 30446.69553304483, 30536.69463305361, 30575.0, 30594.84702576495, 5177.818776342848, 5193.506616871391, 5194.6883187008525, 5208.427073021964, 5229.163333866563, 181375.0, 182031.0, 182329.0, 182602.0, 183462.0, 46039.309410358874, 46146.76926615345, 46250.30624540635, 46354.30468542974, 46439.76780116078, 48943.755281224076, 49116.0, 49138.508614914106, 49144.50855491399, 49191.0, 13878.861211387959, 14201.644958876112, 14231.573052808433, 14238.074525156038, 14240.715185696228, 11668.066554675606, 11676.70808229784, 11689.415529223505, 11760.941195293968, 11771.470283837249, 14025.649358766112, 14206.07660502064, 14230.430782768573, 14325.35535900887, 14390.712185756227, 5657.717114144276, 5678.290213723285, 5693.4875861172695, 5700.37295897451, 5959.539912721411, 1000.7898341348398, 1018.1956254558816, 1022.3201570955232, 1027.4811220333684, 1038.7039693687263, 22763.658545121838, 22866.970986305656, 22931.197408090637, 22958.65562016571, 23274.8836255821, 1099.8460215569826, 1105.4859490337033, 1115.6597237842373, 1121.388843080523, 1134.0417347341483, 11987.820182697267, 12010.819837702442, 12053.337066461429, 12123.696907577381, 12218.816717749241, 211572.0, 213871.0, 213977.0, 214248.0, 214656.0, 51811.48188518066, 52632.0, 53362.7331863346, 53548.464515354346, 53811.73094134504, 1400.9019368644301, 1437.856214378554, 1443.1846007006009, 1453.840077591464, 1456.6795305032877, 26145.084922027636, 26393.340166495993, 26449.735502644726, 26976.460470790866, 27089.1873243803, 36752.816235918646, 36859.0, 36861.07847303839, 36961.0, 36961.0, 185875.0, 187306.0, 187582.0, 187826.0, 188405.0, 33285.50071748877, 33298.833505832314, 33369.83315083506, 33626.159346015564, 33684.0, 39929.60070399259, 40654.79672601618, 40697.59302406938, 40991.590084098774, 41413.0, 30188.69811301859, 30263.0, 30826.69173308328, 30830.229244269074, 31732.682673172974, 30307.545386818776, 30329.545056824605, 30601.08196754101, 30648.778494322993, 30649.233769155057, 34658.133546661535, 34848.0, 34856.12859678528, 35017.649823502456, 35018.474722879684, 30277.0, 30390.0, 30438.086857394315, 30519.23701907381, 30806.537901931042, 22713.772862271828, 23149.42126446852, 23192.536149277257, 23431.531369372857, 23562.646560301953], "value": 16744.800481504208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6747154122149, 587.6239206907583, 588.3904881848997, 598.9191459153013, 618.8731310081433, 22059.33821985341, 22864.0, 22955.08179672811, 22978.88510557449, 22990.310290691305, 20042.699359509617, 21064.684029739565, 21396.8930155349, 21494.0, 21623.6756448653, 6480.611163330203, 6623.867522649544, 6633.535652504326, 6633.767818126366, 6650.5012124090645, 6437.935620643804, 6503.707333169995, 6504.609723416586, 6506.93493065068, 6543.280239173687, 6716.93283067168, 6718.563293385914, 6729.293424190439, 6738.663066846662, 6739.8652026959435, 6713.731450741964, 6719.529632925697, 6726.159230096238, 6731.192256929151, 6731.899021514657, 6070.696465176724, 6276.372362763733, 6291.1192433059405, 6310.589811662273, 6312.589681670676, 28687.426251474855, 29134.0, 29224.41551168986, 29230.85384573085, 29271.121866344045, 1948.2109745553073, 2025.5037515808574, 2031.9695204571942, 2037.7554693436882, 2044.31515442327, 19135.330263440712, 19595.314164004332, 19674.40976770699, 19763.0, 19985.100670469863, 2467.851928884255, 2468.1731619907355, 2499.187763976715, 2504.6743923290037, 2515.3585835611802, 119994.0, 125968.0, 133171.0, 134608.0, 139730.0, 14739.189344585937, 14744.336504857307, 14795.931118942162, 15100.169490678118, 15168.69931900741, 23535.0, 23548.64677029846, 23593.0562777487, 23616.40958976005, 23654.64518032231, 9840.0, 9873.80252394948, 9911.65309214174, 9983.0, 10059.849102263472, 9046.773830654287, 9115.225205857443, 9144.177024067732, 9202.079792020879, 9247.583858726239, 8957.387670219423, 9010.549472526347, 9172.174504294646, 9192.402493837879, 9204.493752843524, 2717.293503689055, 2734.179746076209, 2847.601335812988, 2889.1477014280417, 2892.3203047283873, 946.1720994130136, 957.9521023948774, 964.5563041001078, 977.4965892565192, 977.9511024448891, 18536.81463185378, 18979.0, 19267.325643602406, 19295.324663636704, 19549.511262218275, 1002.9147522460527, 1008.4604736465956, 1012.9088382045651, 1018.8777346718441, 1025.610268098118, 10456.477176141163, 10485.37087774736, 10656.467176641292, 10681.465926703633, 10764.730881728019, 465368.0, 470734.0, 472220.0, 478159.0, 488640.0, 103063.4846825761, 106531.0, 106592.46703766432, 108270.0, 109890.0, 1061.135174832509, 1104.111190491662, 1138.823482360219, 1145.204083162211, 1182.645206438065, 20075.0966206524, 20134.79865201329, 20210.494737631678, 20233.392998210078, 20329.085191166138, 57915.420845791006, 60392.0, 60422.69788651029, 60545.0, 61968.380316196264, 72932.0, 75056.0, 75487.0, 75871.0, 77053.0, 14343.426262949366, 14374.640633984234, 14525.78211326852, 14662.0, 14663.56009319722, 22664.886675566515, 22690.432739180993, 22722.20472283462, 22958.0, 22969.540609188058, 18082.909585451987, 18198.090095494907, 18423.355182568546, 18486.81513184905, 18632.0, 15198.79617455485, 15609.297581608627, 15794.36822527086, 15903.363865445715, 15996.360145594512, 17554.94670319785, 18285.0, 18673.0, 18818.52953676169, 18994.905025474785, 14236.572902812932, 14369.066010709688, 14390.136591804525, 14433.35049922735, 14487.420503179756, 17823.554411139827, 17840.821591783915, 18080.367187148386, 18121.456356309332, 18128.093595320446], "value": 11889.369693842893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.9473221071155, 1375.566696490606, 1379.1518216296975, 1379.6757761925946, 1384.6538365408642, 15024.924875375622, 16213.756793648075, 16232.75650865238, 16237.431689890842, 16246.593835154097, 15827.208639568003, 16092.919535402336, 16106.83893161068, 16107.597310067225, 16129.193540322965, 2721.5781553859183, 2776.569631707089, 2776.6112744215825, 2777.472280266753, 2779.1523585306472, 2697.2582539801515, 2706.377533167373, 2737.1651646247888, 2737.4525094980986, 2739.397332586828, 2584.8578328191943, 2679.370347968226, 2679.450712603921, 2743.1496236166854, 2747.175847245828, 2743.8353698778037, 2775.4726601945667, 2777.8749956251813, 2779.1523585306472, 2781.2629653141935, 2474.0474917156844, 2517.874106294678, 2524.8106392020486, 2533.9239822805343, 2633.2890119667773, 15006.624834379229, 15136.848631513763, 15138.772918406232, 15147.166905820175, 15160.696786064216, 7912.327452166573, 8147.592620369017, 8150.3479721622125, 8152.225538573826, 8186.099529051799, 5110.744462776846, 5382.111951527993, 5396.541293990015, 5420.891582168374, 5517.0, 1916.8945707986056, 1950.112698722078, 1962.8429725621916, 2018.929337473196, 2029.4621925189836, 25816.225513234443, 25820.354491137685, 25860.224193274233, 25870.6119408209, 25986.74013259881, 6633.2703402625675, 6658.600483970978, 6680.532362734659, 6839.521233513607, 6849.1780986281965, 16913.492595222164, 16972.321107155574, 16991.0, 17015.14924253807, 17027.404040858757, 7189.676464559107, 7300.6349682515665, 7311.4516411268305, 7332.156801967842, 7335.193128755833, 6673.099131617267, 6810.795676129724, 6836.623985680835, 6915.965420172867, 6923.757668481579, 5119.360079990001, 5197.064528384927, 5260.868478288074, 5291.920621190685, 5319.361676598833, 1500.482333594908, 1502.6994601079828, 1518.6507103366287, 1522.5204060720837, 1549.264099552726, 871.4727589808075, 893.6336102198068, 902.9322800789967, 909.2816674826813, 915.9771005724776, 7582.924170758332, 7602.429817763579, 7662.923370766221, 7665.233476652402, 7745.651445684957, 722.8734971379987, 726.8800647893144, 727.2291371146496, 733.043378391194, 734.8530293941233, 4742.430908291027, 5060.84817455477, 5193.714345710947, 5458.972705136528, 5471.4528547145765, 21114.577708445744, 22028.88985555062, 22065.33803985883, 22177.223797167022, 22354.888225558767, 20919.0, 21886.45283867884, 21945.890270548545, 21993.560128797333, 22026.11895524193, 10514.106300964504, 10624.468776561142, 10639.042486176282, 10647.627333043307, 10651.360918344924, 7728.601210960417, 8070.192980702118, 8112.22933821286, 8171.509709417454, 8187.385946053951, 17934.0, 18371.448856534324, 18418.0, 18533.98063106542, 18949.810501895357, 18924.0, 18960.146793394608, 19137.425877223148, 19536.706949395488, 19585.118669659616, 10418.114460270659, 10454.215933805148, 10472.476376181314, 10580.788384232119, 10624.84062739044, 13148.211107333591, 13269.933650331686, 13314.267715275366, 13326.86673133295, 13334.533291334757, 10003.199744020607, 10019.148372388428, 10043.69868903934, 10070.295079344376, 10303.845442318221, 10382.688519344432, 10467.371957682564, 10572.577096916037, 10730.302530335503, 10799.73000674958, 8931.062238464867, 9024.142706442877, 9121.543922803967, 9124.31567632417, 9153.130452606993, 6916.619585922823, 7114.928850711427, 7145.571265724073, 7176.007680407508, 7279.490435669452, 7264.527805692613, 7369.8157546061775, 7387.9261207387235, 7391.334779869838, 7542.170361260367], "value": 6519.277139525155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.4967731623008, 523.6884053987878, 548.0737553534526, 553.3553410277027, 560.2324815003445, 6172.783952561661, 6234.781782637609, 6311.936880631192, 6346.365363463651, 6395.840103997402, 6271.184745983027, 6272.4041216084515, 6317.494600431966, 6325.588836725621, 6344.048392741091, 5195.467337135535, 5212.139996900507, 5229.712365819897, 5282.0, 5301.284326615906, 4946.9752651236695, 5097.643164978453, 5135.152699804527, 5245.475452454743, 5247.501487358714, 5047.570956468686, 5067.467915868836, 5095.210242412432, 5104.5405913467785, 5141.537261646451, 5051.166557518023, 5067.771950262247, 5068.543831055223, 5076.289319495274, 5111.6166287528395, 4605.769711514411, 4616.799632095645, 4620.422447194101, 4623.514530974233, 4668.409032986691, 6172.598781079216, 6269.843253918643, 6271.278802937675, 6333.321669757518, 6351.142595749607, 5715.857103572403, 5775.624584402, 5803.7968671096305, 5847.0, 5855.3851845556455, 6649.335066493312, 6649.800505984828, 6692.966535167293, 6693.832654183636, 6716.3283671632935, 4943.283223932545, 5005.698518385246, 5006.74966251686, 5039.622028347889, 5043.445221025684, 6926.965365173141, 6999.265077166875, 7008.299170083002, 7078.292170782932, 7085.362317391408, 5087.26234695967, 5091.796328146833, 5097.796088156432, 5098.337216161949, 5120.436751957282, 5198.81804136861, 5202.323697919322, 5225.23062776729, 5226.764795584208, 5227.163653815372, 5803.738831752581, 5813.854653633693, 5832.88334233313, 5845.749386486148, 5861.824145275648, 6309.305976342599, 6678.365555272241, 6699.832504187337, 6722.294159113223, 6778.694958726869, 1670.3485640600175, 1703.49746824687, 1706.5904182995992, 1746.7379893015896, 1787.1153778879539, 1217.7578869553006, 1223.6696092055095, 1227.2391117507202, 1243.2966835435511, 1248.1949142803023, 5654.9151762723595, 5673.659580425187, 5719.342275638355, 5744.0, 5751.338596061507, 6454.870902581922, 6731.831704207434, 6753.932460675429, 6780.897921644306, 6796.878515044962, 5630.73308505583, 5666.150077488327, 5737.426257374229, 5752.712364381764, 5775.971120144372, 3534.8586056557965, 3542.98228508861, 3561.8753343632848, 3597.6582224688614, 3617.3850445423814, 6461.544613047012, 6554.63949482783, 6556.836079097965, 6597.637129957899, 6612.23959244693, 6907.240203577602, 6909.894416893273, 6912.827179320457, 6933.0, 6948.652567371611, 6540.738370465128, 6557.836054098686, 6590.209174899042, 6596.274409814917, 6628.602283862983, 6753.696083676345, 6786.8642627148165, 6794.641071785564, 6850.725970961105, 6875.690593923386, 6729.73081076771, 6730.990351447322, 6746.8650626988165, 6838.93161068383, 6842.623655698984, 6405.558749281561, 6445.967770161119, 6498.090267362479, 6548.0, 6579.671016449254, 5003.824866129668, 5018.172001619692, 5050.646454748133, 5067.493250674903, 5092.821751238689, 6429.5499315049365, 6617.602943823386, 6877.277885821916, 6888.311168883071, 6903.1716194055025, 6232.626042437469, 6428.164338635947, 6506.909218121355, 6583.65035167799, 6588.934110658832, 6391.201099862517, 6421.683554871333, 6505.0, 6563.638999855054, 6617.404433600999, 6333.80143027768, 6391.936080639134, 6425.839354016187, 6434.742610295536, 6553.803385898431, 6452.419282264619, 6591.736330546724, 6599.934000659932, 6625.635590042594, 6644.302348253364, 6244.812655620339, 6314.179156709598, 6355.237371515448, 6388.137601423934, 6411.006294024433], "value": 5122.067919093958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [926.6849271247777, 931.3154831199067, 936.1901954809092, 941.4586612697697, 949.6771097826737, 16717.331306747732, 17077.0, 17077.658446831058, 17105.144742762874, 17109.144542772858, 15365.154916479589, 17300.653986920253, 17446.738298925527, 17448.38930637428, 17467.039312837787, 969.2343048991288, 986.7434467038586, 989.5052473763119, 989.7773001074737, 990.3067852503241, 946.820104180207, 975.2539307429822, 977.6871401151634, 982.0670363154995, 989.2036910287252, 1035.4512108582426, 1039.230969082877, 1040.3445829127677, 1041.3803786746873, 1041.5052849896315, 1024.109025148122, 1024.6260115057987, 1025.933314334566, 1035.3735989726183, 1036.6682661548307, 755.3088923634867, 756.7124492692797, 757.8257000889771, 757.8673732096917, 758.0751483190498, 16694.165291735364, 16747.0, 16750.246238919277, 16768.748468772857, 16792.832071679248, 21351.359459216248, 22037.0, 22260.666090008664, 22266.88866555673, 22277.554448911094, 15975.76036359444, 17182.484525464257, 17309.307627694878, 17380.130993450275, 17390.47828565145, 3744.4944932434046, 3750.9437358439645, 3769.5288088988877, 3770.3401904666575, 3857.5370955485523, 134237.0, 134617.0, 138602.0, 139597.0, 140102.0, 15598.53204403847, 15910.602234943988, 15987.280572374271, 16103.436379726654, 16111.0, 24761.752382475945, 24810.5037899241, 24814.627780583305, 24855.62716559253, 24936.376590585016, 9045.954770226106, 9133.0, 9145.268378529701, 9236.307276954256, 9250.583723732449, 4442.4669039715445, 4557.1797076526545, 4561.840335588238, 4565.885852853705, 4567.931481027787, 5451.3458384994055, 5508.283923089973, 5527.972360138254, 5548.4174161712435, 5557.083081291542, 1005.6429967361628, 1005.9497025148713, 1008.1178968402647, 1015.9136473399695, 1023.150784848574, 694.354250546986, 707.5754547271596, 714.5177005521252, 724.6557885004686, 736.576468530597, 11595.594154204562, 11765.352465937529, 12358.196717213352, 12992.285424301564, 13308.800367994489, 687.5290426058166, 700.2332445971653, 703.8486725353971, 713.4862898712919, 719.9352058314777, 5550.045602475987, 5595.608307418442, 5648.6893220872425, 5682.971585142048, 5763.394843541368, 125998.0, 126437.36781316035, 126979.0, 128614.0, 128821.0, 107554.0, 110354.44822775834, 111398.44300778444, 112544.4372778131, 114607.42696286632, 91193.0, 91504.0, 92741.99999999865, 94970.0, 95935.52032239933, 10452.007059329351, 10460.0, 10503.474826258504, 10597.099246564128, 10831.404272764757, 43441.78279108584, 44100.45648402291, 44562.55437445584, 45166.548334516236, 45887.31169032534, 55838.72080639571, 57217.427825721206, 57636.71181644065, 58911.11633325418, 59143.0, 14890.85109148938, 14896.255187240811, 14947.925260373628, 15029.774553381927, 15069.924650376677, 17365.0, 17442.825571744626, 17482.30070797205, 17576.56058598545, 17711.46865594034, 13418.530351437652, 13720.725585488035, 13737.313134343043, 13765.931170344084, 13775.793363099361, 13939.233342166279, 13993.090449120775, 14024.649383765487, 14057.086289391156, 14080.859191407955, 14544.27278636085, 14722.926385368004, 14826.62933426673, 15037.548873533811, 15281.46514871974, 11343.319400835977, 11488.827667584826, 11641.53433862636, 11741.17811753169, 11760.235584686969, 12309.876901231231, 12330.445129969352, 12427.192232504858, 12501.24992500453, 12682.239065656091], "value": 8767.597052728035, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 107.0, 107.0, 107.0, 95.0, 110.0, 108.0, 109.0, 108.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 115.0, 119.0, 117.0, 119.0, 115.0, 147.0, 119.0, 117.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 163.0, 163.0, 163.0, 163.0, 167.0, 170.0, 166.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 74.0, 74.0, 73.0, 73.0, 73.0, 77.0, 73.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 80.0, 78.0, 79.0, 79.0, 79.0, 79.0, 78.0, 83.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 147.0, 148.0, 147.0, 150.0, 148.0, 151.0, 148.0, 150.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 93.0, 99.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 39.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 73.0, 74.0, 88.0, 73.0, 74.0, 72.0, 71.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 113.0, 111.0, 117.0, 111.0, 115.0, 113.0, 111.0, 116.0], "value": 112.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 166.0, 175.0, 168.0, 168.0, 168.0, 172.0, 181.0, 166.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 65.0, 65.0, 67.0, 74.0, 63.0, 67.0, 64.0], "value": 65.8, "unit": "score"}]}]} 17:13:04 INFO - Return code: 0 17:13:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:13:04 INFO - # TBPL SUCCESS # 17:13:04 INFO - Running post-action listener: _package_coverage_data 17:13:04 INFO - Running post-action listener: _resource_record_post_action 17:13:04 INFO - [mozharness: 2017-09-27 00:13:04.882791Z] Finished run-tests step (success) 17:13:04 INFO - Running post-run listener: _resource_record_post_run 17:13:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 9322496; Write bytes: 536166400; Read time: 3068; Write time: 463504 17:13:04 INFO - TinderboxPrint: CPU usage
13.1% 17:13:04 INFO - TinderboxPrint: I/O read bytes / time
9,322,496 / 3,068 17:13:04 INFO - TinderboxPrint: I/O write bytes / time
536,166,400 / 463,504 17:13:04 INFO - TinderboxPrint: CPU idle
8,261.8 (86.9%) 17:13:04 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 17:13:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:13:04 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 161492992; Read time: 0; Write time: 132796 17:13:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:13:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 7577600; Write bytes: 374673408; Read time: 3008; Write time: 330708 17:13:05 INFO - Running post-run listener: _upload_blobber_files 17:13:05 INFO - Blob upload gear active. 17:13:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:13:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:13:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:13:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:13:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:13:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:06 INFO - (blobuploader) - INFO - Done attempting. 17:13:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:13:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:08 INFO - (blobuploader) - INFO - Done attempting. 17:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:09 INFO - (blobuploader) - INFO - Done attempting. 17:13:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:13:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:13:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:16 INFO - (blobuploader) - INFO - Done attempting. 17:13:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:16 INFO - Return code: 0 17:13:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/454cf716e372bce4bc2a409631751710b07c0d9bb333724b916f26b81b749f0c97764d389d672282c29220ef3c19328e1287064cde44798785b85a446a5902d9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c627069396027ad09347c25cb4259377265b4f15dd5a33bbdbed16b7a6725c53cc2f1be48a7b32bc5a53c8f8fe25c73d1cc4cee4b452a59c8bd5960691eb97", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dcbcdf49118efe46e26a0b8758d380519731045c566ff6961046b7a4350bfac5a6a24a6cc7d1843e99ad04704fb92591fd4bb62fb80d1e2c42588ee88be7c53", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baeb1223818887f75642af8c686d6dfd9b8752f931a54b27332427db93dd0cf1ae2dd6fc724b5f06a5f716feeb3a46c155b44cf36df9f13ff872cc64f7aaae62"} 17:13:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:16 INFO - Contents: 17:13:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/454cf716e372bce4bc2a409631751710b07c0d9bb333724b916f26b81b749f0c97764d389d672282c29220ef3c19328e1287064cde44798785b85a446a5902d9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c627069396027ad09347c25cb4259377265b4f15dd5a33bbdbed16b7a6725c53cc2f1be48a7b32bc5a53c8f8fe25c73d1cc4cee4b452a59c8bd5960691eb97", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dcbcdf49118efe46e26a0b8758d380519731045c566ff6961046b7a4350bfac5a6a24a6cc7d1843e99ad04704fb92591fd4bb62fb80d1e2c42588ee88be7c53", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baeb1223818887f75642af8c686d6dfd9b8752f931a54b27332427db93dd0cf1ae2dd6fc724b5f06a5f716feeb3a46c155b44cf36df9f13ff872cc64f7aaae62"} 17:13:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:16 INFO - Copying logs to upload dir... 17:13:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.999907 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-26 17:13:16.993078) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:16.997038) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269 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-Non-PGO/sha512/454cf716e372bce4bc2a409631751710b07c0d9bb333724b916f26b81b749f0c97764d389d672282c29220ef3c19328e1287064cde44798785b85a446a5902d9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c627069396027ad09347c25cb4259377265b4f15dd5a33bbdbed16b7a6725c53cc2f1be48a7b32bc5a53c8f8fe25c73d1cc4cee4b452a59c8bd5960691eb97", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dcbcdf49118efe46e26a0b8758d380519731045c566ff6961046b7a4350bfac5a6a24a6cc7d1843e99ad04704fb92591fd4bb62fb80d1e2c42588ee88be7c53", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baeb1223818887f75642af8c686d6dfd9b8752f931a54b27332427db93dd0cf1ae2dd6fc724b5f06a5f716feeb3a46c155b44cf36df9f13ff872cc64f7aaae62"} build_url:https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/HLKvdi3eRuyWAkkyUmZMZA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/454cf716e372bce4bc2a409631751710b07c0d9bb333724b916f26b81b749f0c97764d389d672282c29220ef3c19328e1287064cde44798785b85a446a5902d9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1c627069396027ad09347c25cb4259377265b4f15dd5a33bbdbed16b7a6725c53cc2f1be48a7b32bc5a53c8f8fe25c73d1cc4cee4b452a59c8bd5960691eb97", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dcbcdf49118efe46e26a0b8758d380519731045c566ff6961046b7a4350bfac5a6a24a6cc7d1843e99ad04704fb92591fd4bb62fb80d1e2c42588ee88be7c53", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/baeb1223818887f75642af8c686d6dfd9b8752f931a54b27332427db93dd0cf1ae2dd6fc724b5f06a5f716feeb3a46c155b44cf36df9f13ff872cc64f7aaae62"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:17.027656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:17.027970) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506468934.556359-1716370269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004339 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 17:13:17.077898) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:13:17.081222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 17:13:17.081542) ========= ========= Total master_lag: 0.19 =========