builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-043 starttime: 1506122850.32 results: success (0) revision: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.316253) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.329231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.329725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.389920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.390256) ========= 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=d2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 16:27:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.6M=0.001s 2017-09-22 16:27:30 (17.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.529685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.530030) ========= 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=d2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018978 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.584067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:30.584427) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 --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 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 --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=d2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 16:27:30,600 truncating revision to first 12 chars 2017-09-22 16:27:30,600 Setting DEBUG logging. 2017-09-22 16:27:30,600 attempt 1/10 2017-09-22 16:27:30,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d72fdb0e561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 16:27:30,902 unpacking tar archive at: mozilla-central-3d72fdb0e561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:31.265640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:31.266038) ========= script_repo_revision: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:31.266481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:31.266779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 16:27:31.284553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-22 16:27:31.285023) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:27:31 INFO - MultiFileLogger online at 20170922 16:27:31 in /builds/slave/test 16:27:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:27:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:27:31 INFO - {'append_to_log': False, 16:27:31 INFO - 'base_work_dir': '/builds/slave/test', 16:27:31 INFO - 'blob_upload_branch': 'Firefox', 16:27:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:27:31 INFO - 'branch': 'Firefox', 16:27:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:27:31 INFO - 'code_coverage': False, 16:27:31 INFO - 'config_files': ('talos/linux_config.py',), 16:27:31 INFO - 'default_actions': ('clobber', 16:27:31 INFO - 'read-buildbot-config', 16:27:31 INFO - 'download-and-extract', 16:27:31 INFO - 'populate-webroot', 16:27:31 INFO - 'create-virtualenv', 16:27:31 INFO - 'install', 16:27:31 INFO - 'setup-mitmproxy', 16:27:31 INFO - 'run-tests'), 16:27:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:27:31 INFO - 'disable_ccov_upload': False, 16:27:31 INFO - 'disable_stylo': False, 16:27:31 INFO - 'download_minidump_stackwalk': True, 16:27:31 INFO - 'download_symbols': 'ondemand', 16:27:31 INFO - 'enable_stylo': False, 16:27:31 INFO - 'enable_webrender': False, 16:27:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:27:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:27:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:27:31 INFO - 'gecko_profile': False, 16:27:31 INFO - 'gecko_profile_interval': 0, 16:27:31 INFO - 'installer_path': 'installer.exe', 16:27:31 INFO - 'log_level': 'info', 16:27:31 INFO - 'log_name': 'talos', 16:27:31 INFO - 'log_to_console': True, 16:27:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:27:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:27:31 INFO - 'opt_config_files': (), 16:27:31 INFO - 'pip_index': False, 16:27:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:27:31 INFO - 'system_bits': '32', 16:27:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:27:31 INFO - 'title': 'talos-linux64-ix-043', 16:27:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:27:31 INFO - 'use_talos_json': True, 16:27:31 INFO - 'verify': 'False', 16:27:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:27:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:27:31 INFO - 'work_dir': 'build'} 16:27:31 INFO - [mozharness: 2017-09-22 23:27:31.441439Z] Running clobber step. 16:27:31 INFO - Running pre-action listener: _resource_record_pre_action 16:27:31 INFO - Running main action method: clobber 16:27:31 INFO - rmtree: /builds/slave/test/build 16:27:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:27:32 INFO - Running post-action listener: _resource_record_post_action 16:27:32 INFO - [mozharness: 2017-09-22 23:27:32.981326Z] Finished clobber step (success) 16:27:32 INFO - [mozharness: 2017-09-22 23:27:32.981424Z] Running read-buildbot-config step. 16:27:32 INFO - Running pre-action listener: _resource_record_pre_action 16:27:32 INFO - Running main action method: read_buildbot_config 16:27:32 INFO - Using buildbot properties: 16:27:32 INFO - { 16:27:32 INFO - "project": "", 16:27:32 INFO - "product": "firefox", 16:27:32 INFO - "who": "kwierso@gmail.com", 16:27:32 INFO - "installer_path": "public/build/target.tar.bz2", 16:27:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:27:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:27:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:27:32 INFO - "stage_platform": "linux64-pgo", 16:27:32 INFO - "basedir": "/builds/slave/test", 16:27:32 INFO - "buildnumber": 35, 16:27:32 INFO - "platform": "ubuntu64_hw", 16:27:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:27:32 INFO - "slavebuilddir": "test", 16:27:32 INFO - "taskId": "NfO1dn1_SfuetH686dAi-A", 16:27:32 INFO - "branch": "mozilla-central", 16:27:32 INFO - "script_repo_revision": "production", 16:27:32 INFO - "revision": "3d72fdb0e561ea59d9e5850c3e71367dbb8a7148", 16:27:32 INFO - "slavename": "talos-linux64-ix-043", 16:27:32 INFO - "repo_path": "mozilla-central" 16:27:32 INFO - } 16:27:32 INFO - Finding installer, test and symbols from parent task. 16:27:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfO1dn1_SfuetH686dAi-A'}, attempt #1 16:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfO1dn1_SfuetH686dAi-A'}, attempt #1 16:27:33 INFO - Task dependencies: cbFdpQ8wTE6HRI4Bano6mQ 16:27:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ'}, attempt #1 16:27:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2 16:27:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.test_packages.json 16:27:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.crashreporter-symbols.zip 16:27:34 INFO - Running post-action listener: _resource_record_post_action 16:27:34 INFO - [mozharness: 2017-09-22 23:27:34.297459Z] Finished read-buildbot-config step (success) 16:27:34 INFO - [mozharness: 2017-09-22 23:27:34.297675Z] Running download-and-extract step. 16:27:34 INFO - Running pre-action listener: _resource_record_pre_action 16:27:34 INFO - Running main action method: download_and_extract 16:27:34 INFO - mkdir: /builds/slave/test/build/tests 16:27:34 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:27:34 INFO - trying https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.test_packages.json 16:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:27:34 INFO - Downloaded 989 bytes. 16:27:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:27:34 INFO - Using the following test package requirements: 16:27:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:27:34 INFO - u'common': [u'target.common.tests.zip'], 16:27:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:27:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:27:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:27:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:27:34 INFO - u'mozbase': [u'target.common.tests.zip'], 16:27:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:27:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:27:34 INFO - u'web-platform': [u'target.common.tests.zip', 16:27:34 INFO - u'target.web-platform.tests.tar.gz'], 16:27:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:27:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:27:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.common.tests.zip 16:27:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:27:34 INFO - Fetch https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.common.tests.zip into memory 16:27:36 INFO - Content-Length response header: 55342278 16:27:36 INFO - Bytes received: 55342278 16:27:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.talos.tests.zip 16:27:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:27:46 INFO - Fetch https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.talos.tests.zip into memory 16:27:47 INFO - Content-Length response header: 14513823 16:27:47 INFO - Bytes received: 14513823 16:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:47 INFO - trying https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2 16:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:27:49 INFO - Downloaded 62376189 bytes. 16:27:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2 16:27:49 INFO - mkdir: /builds/slave/test/properties 16:27:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:27:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:27:49 INFO - Contents: 16:27:49 INFO - build_url:https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2 16:27:49 INFO - Running post-action listener: _resource_record_post_action 16:27:49 INFO - Running post-action listener: find_tests_for_verification 16:27:49 INFO - Running post-action listener: set_extra_try_arguments 16:27:49 INFO - [mozharness: 2017-09-22 23:27:49.893706Z] Finished download-and-extract step (success) 16:27:49 INFO - [mozharness: 2017-09-22 23:27:49.893938Z] Running populate-webroot step. 16:27:49 INFO - Running pre-action listener: _resource_record_pre_action 16:27:49 INFO - Running main action method: populate_webroot 16:27:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:27:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['tresize', 16:27:49 INFO - 'tcanvasmark']}, 16:27:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:27:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['dromaeo_css', 16:27:49 INFO - 'kraken']}, 16:27:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:27:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'tests': ['damp', 'tps']}, 16:27:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['damp', 'tps']}, 16:27:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:27:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['dromaeo_dom']}, 16:27:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:27:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['basic_compositor_video', 16:27:49 INFO - 'glvideo']}, 16:27:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:27:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['ts_paint_webext', 16:27:49 INFO - 'tp5o_webext']}, 16:27:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:27:49 INFO - 'ts_paint', 16:27:49 INFO - 'tpaint', 16:27:49 INFO - 'sessionrestore', 16:27:49 INFO - 'sessionrestore_many_windows', 16:27:49 INFO - 'sessionrestore_no_auto_restore', 16:27:49 INFO - 'tabpaint']}, 16:27:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['a11yr', 16:27:49 INFO - 'ts_paint', 16:27:49 INFO - 'tpaint', 16:27:49 INFO - 'sessionrestore', 16:27:49 INFO - 'sessionrestore_many_windows', 16:27:49 INFO - 'sessionrestore_no_auto_restore', 16:27:49 INFO - 'tabpaint']}, 16:27:49 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:27:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:27:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['perf_reftest_singletons']}, 16:27:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['perf_reftest']}, 16:27:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:27:49 INFO - 'tsvgr_opacity', 16:27:49 INFO - 'tart', 16:27:49 INFO - 'tscrollx', 16:27:49 INFO - 'tsvg_static']}, 16:27:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['tsvgx', 16:27:49 INFO - 'tsvgr_opacity', 16:27:49 INFO - 'tart', 16:27:49 INFO - 'tscrollx', 16:27:49 INFO - 'tsvg_static']}, 16:27:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:27:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'talos_options': ['--disable-stylo'], 16:27:49 INFO - 'tests': ['tp5o']}, 16:27:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:27:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:27:49 INFO - 'talos_options': ['--mitmproxy', 16:27:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:27:49 INFO - '--firstNonBlankPaint'], 16:27:49 INFO - 'tests': ['tp6_google', 16:27:49 INFO - 'tp6_youtube', 16:27:49 INFO - 'tp6_amazon', 16:27:49 INFO - 'tp6_facebook']}, 16:27:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:27:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:27:49 INFO - 'talos_options': ['--disable-stylo', 16:27:49 INFO - '--mitmproxy', 16:27:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:27:49 INFO - '--firstNonBlankPaint'], 16:27:49 INFO - 'tests': ['tp6_google', 16:27:49 INFO - 'tp6_youtube', 16:27:49 INFO - 'tp6_amazon', 16:27:49 INFO - 'tp6_facebook']}, 16:27:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:27:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:27:49 INFO - 'talos_options': ['--stylo-threads=1', 16:27:49 INFO - '--mitmproxy', 16:27:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:27:49 INFO - '--firstNonBlankPaint'], 16:27:49 INFO - 'tests': ['tp6_google', 16:27:49 INFO - 'tp6_youtube', 16:27:49 INFO - 'tp6_amazon', 16:27:49 INFO - 'tp6_facebook']}, 16:27:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'talos_options': ['--xperf_path', 16:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:49 INFO - 'tests': ['tp5n']}, 16:27:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:27:49 INFO - 'talos_options': ['--disable-stylo', 16:27:49 INFO - '--xperf_path', 16:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:27:49 INFO - 'tests': ['tp5n']}}} 16:27:49 INFO - Running post-action listener: _resource_record_post_action 16:27:49 INFO - [mozharness: 2017-09-22 23:27:49.910581Z] Finished populate-webroot step (success) 16:27:49 INFO - [mozharness: 2017-09-22 23:27:49.910699Z] Running create-virtualenv step. 16:27:49 INFO - Running pre-action listener: _resource_record_pre_action 16:27:49 INFO - Running main action method: create_virtualenv 16:27:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:27:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:27:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:27:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:27:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:27:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:27:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:27:50 INFO - Installing pip...............done. 16:27:50 INFO - Return code: 0 16:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:27:50 INFO - Reading from file tmpfile_stdout 16:27:50 INFO - Output received: 16:27:50 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:27:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:27:50 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:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:50 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:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:50 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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:27:50 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:27:50 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:27:50 INFO - Using env: {'DISPLAY': ':0', 16:27:50 INFO - 'HOME': '/home/cltbld', 16:27:50 INFO - 'LANG': 'en_US.UTF-8', 16:27:50 INFO - 'LANGUAGE': 'en_US:en', 16:27:50 INFO - 'LOGNAME': 'cltbld', 16:27:50 INFO - 'MAIL': '/var/mail/cltbld', 16:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:50 INFO - 'MOZ_NO_REMOTE': '1', 16:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:50 INFO - 'NO_EM_RESTART': '1', 16:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:50 INFO - 'PWD': '/builds/slave/test', 16:27:50 INFO - 'SHELL': '/bin/bash', 16:27:50 INFO - 'SHLVL': '1', 16:27:50 INFO - 'TERM': 'linux', 16:27:50 INFO - 'TMOUT': '86400', 16:27:50 INFO - 'USER': 'cltbld', 16:27:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:50 INFO - '_': '/tools/buildbot/bin/python'} 16:27:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:27:52 INFO - Downloading/unpacking pip>=1.5 16:27:52 INFO - Running setup.py egg_info for package pip 16:27:52 INFO - warning: no files found matching 'pip/cacert.pem' 16:27:52 INFO - warning: no files found matching '*.html' under directory 'docs' 16:27:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:27:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:27:52 INFO - Installing collected packages: pip 16:27:52 INFO - Found existing installation: pip 1.1 16:27:52 INFO - Uninstalling pip: 16:27:52 INFO - Successfully uninstalled pip 16:27:52 INFO - Running setup.py install for pip 16:27:52 INFO - warning: no files found matching 'pip/cacert.pem' 16:27:52 INFO - warning: no files found matching '*.html' under directory 'docs' 16:27:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:27:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:27:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:27:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:27:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:27:52 INFO - Successfully installed pip 16:27:52 INFO - Cleaning up... 16:27:52 INFO - Return code: 0 16:27:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:27: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:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27: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:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27: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', '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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:27: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 psutil>=3.1.1 16:27:52 INFO - Using env: {'DISPLAY': ':0', 16:27:52 INFO - 'HOME': '/home/cltbld', 16:27:52 INFO - 'LANG': 'en_US.UTF-8', 16:27:52 INFO - 'LANGUAGE': 'en_US:en', 16:27:52 INFO - 'LOGNAME': 'cltbld', 16:27:52 INFO - 'MAIL': '/var/mail/cltbld', 16:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:52 INFO - 'MOZ_NO_REMOTE': '1', 16:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:52 INFO - 'NO_EM_RESTART': '1', 16:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:52 INFO - 'PWD': '/builds/slave/test', 16:27:52 INFO - 'SHELL': '/bin/bash', 16:27:52 INFO - 'SHLVL': '1', 16:27:52 INFO - 'TERM': 'linux', 16:27:52 INFO - 'TMOUT': '86400', 16:27:52 INFO - 'USER': 'cltbld', 16:27:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:52 INFO - '_': '/tools/buildbot/bin/python'} 16:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:52 INFO - Downloading/unpacking psutil>=3.1.1 16:27:52 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:27:52 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:27:52 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:27:52 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:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:53 INFO - Installing collected packages: psutil 16:27:53 INFO - Running setup.py install for psutil 16:27:53 INFO - building 'psutil._psutil_linux' extension 16:27:53 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:27:53 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:27:53 INFO - building 'psutil._psutil_posix' extension 16:27:53 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:27:53 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:27:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:27:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:27:54 INFO - Successfully installed psutil 16:27:54 INFO - Cleaning up... 16:27:54 INFO - Return code: 0 16:27:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:27: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:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27: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:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:27: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 mozsystemmonitor==0.3 16:27:54 INFO - Using env: {'DISPLAY': ':0', 16:27:54 INFO - 'HOME': '/home/cltbld', 16:27:54 INFO - 'LANG': 'en_US.UTF-8', 16:27:54 INFO - 'LANGUAGE': 'en_US:en', 16:27:54 INFO - 'LOGNAME': 'cltbld', 16:27:54 INFO - 'MAIL': '/var/mail/cltbld', 16:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:54 INFO - 'MOZ_NO_REMOTE': '1', 16:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:54 INFO - 'NO_EM_RESTART': '1', 16:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:54 INFO - 'PWD': '/builds/slave/test', 16:27:54 INFO - 'SHELL': '/bin/bash', 16:27:54 INFO - 'SHLVL': '1', 16:27:54 INFO - 'TERM': 'linux', 16:27:54 INFO - 'TMOUT': '86400', 16:27:54 INFO - 'USER': 'cltbld', 16:27:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:54 INFO - '_': '/tools/buildbot/bin/python'} 16:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:27: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:27: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:27: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:27: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:27:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:27:55 INFO - Installing collected packages: mozsystemmonitor 16:27:55 INFO - Running setup.py install for mozsystemmonitor 16:27:55 INFO - Successfully installed mozsystemmonitor 16:27:55 INFO - Cleaning up... 16:27:57 INFO - Return code: 0 16:27:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:27:57 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:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:57 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:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:57 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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:27:57 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:27:57 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:27:57 INFO - Using env: {'DISPLAY': ':0', 16:27:57 INFO - 'HOME': '/home/cltbld', 16:27:57 INFO - 'LANG': 'en_US.UTF-8', 16:27:57 INFO - 'LANGUAGE': 'en_US:en', 16:27:57 INFO - 'LOGNAME': 'cltbld', 16:27:57 INFO - 'MAIL': '/var/mail/cltbld', 16:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:57 INFO - 'MOZ_NO_REMOTE': '1', 16:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:57 INFO - 'NO_EM_RESTART': '1', 16:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:57 INFO - 'PWD': '/builds/slave/test', 16:27:57 INFO - 'SHELL': '/bin/bash', 16:27:57 INFO - 'SHLVL': '1', 16:27:57 INFO - 'TERM': 'linux', 16:27:57 INFO - 'TMOUT': '86400', 16:27:57 INFO - 'USER': 'cltbld', 16:27:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:57 INFO - '_': '/tools/buildbot/bin/python'} 16:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:27: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:27: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:27: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:27: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:27:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:27:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:27: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:27: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:27: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:27: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:27:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:27:58 INFO - warning: no files found matching '*.txt' 16:27:58 INFO - no previously-included directories found matching 'build' 16:27:58 INFO - no previously-included directories found matching 'dist' 16:27:58 INFO - no previously-included directories found matching '.git*' 16:27:58 INFO - Installing collected packages: jsonschema, functools32 16:27:59 INFO - Running setup.py install for functools32 16:27:59 INFO - warning: no files found matching '*.txt' 16:27:59 INFO - no previously-included directories found matching 'build' 16:27:59 INFO - no previously-included directories found matching 'dist' 16:27:59 INFO - no previously-included directories found matching '.git*' 16:27:59 INFO - Successfully installed jsonschema functools32 16:27:59 INFO - Cleaning up... 16:27:59 INFO - Return code: 0 16:27:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:27:59 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:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:59 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:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:59 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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:27:59 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:27:59 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:27:59 INFO - Using env: {'DISPLAY': ':0', 16:27:59 INFO - 'HOME': '/home/cltbld', 16:27:59 INFO - 'LANG': 'en_US.UTF-8', 16:27:59 INFO - 'LANGUAGE': 'en_US:en', 16:27:59 INFO - 'LOGNAME': 'cltbld', 16:27:59 INFO - 'MAIL': '/var/mail/cltbld', 16:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:59 INFO - 'MOZ_NO_REMOTE': '1', 16:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:59 INFO - 'NO_EM_RESTART': '1', 16:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:59 INFO - 'PWD': '/builds/slave/test', 16:27:59 INFO - 'SHELL': '/bin/bash', 16:27:59 INFO - 'SHLVL': '1', 16:27:59 INFO - 'TERM': 'linux', 16:27:59 INFO - 'TMOUT': '86400', 16:27:59 INFO - 'USER': 'cltbld', 16:27:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:59 INFO - '_': '/tools/buildbot/bin/python'} 16:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:27:59 INFO - Cleaning up... 16:27:59 INFO - Return code: 0 16:27:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:27:59 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:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:27:59 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:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:27:59 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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:27:59 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:27:59 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:27:59 INFO - Using env: {'DISPLAY': ':0', 16:27:59 INFO - 'HOME': '/home/cltbld', 16:27:59 INFO - 'LANG': 'en_US.UTF-8', 16:27:59 INFO - 'LANGUAGE': 'en_US:en', 16:27:59 INFO - 'LOGNAME': 'cltbld', 16:27:59 INFO - 'MAIL': '/var/mail/cltbld', 16:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:27:59 INFO - 'MOZ_NO_REMOTE': '1', 16:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:27:59 INFO - 'NO_EM_RESTART': '1', 16:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:27:59 INFO - 'PWD': '/builds/slave/test', 16:27:59 INFO - 'SHELL': '/bin/bash', 16:27:59 INFO - 'SHLVL': '1', 16:27:59 INFO - 'TERM': 'linux', 16:27:59 INFO - 'TMOUT': '86400', 16:27:59 INFO - 'USER': 'cltbld', 16:27:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:27:59 INFO - '_': '/tools/buildbot/bin/python'} 16:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:27:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:27: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:27: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:27: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:27: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:28:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28: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:28: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:28: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:28: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:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28: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:28: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:28: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:28: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:28:01 INFO - Downloading docopt-0.6.1.tar.gz 16:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:01 INFO - Running setup.py install for blobuploader 16:28:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:01 INFO - Running setup.py install for requests 16:28:02 INFO - Running setup.py install for docopt 16:28:02 INFO - Successfully installed blobuploader requests docopt 16:28:02 INFO - Cleaning up... 16:28:02 INFO - Return code: 0 16:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28: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:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28: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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:28: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:28: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:28:02 INFO - Using env: {'DISPLAY': ':0', 16:28:02 INFO - 'HOME': '/home/cltbld', 16:28:02 INFO - 'LANG': 'en_US.UTF-8', 16:28:02 INFO - 'LANGUAGE': 'en_US:en', 16:28:02 INFO - 'LOGNAME': 'cltbld', 16:28:02 INFO - 'MAIL': '/var/mail/cltbld', 16:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:02 INFO - 'MOZ_NO_REMOTE': '1', 16:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:02 INFO - 'NO_EM_RESTART': '1', 16:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:02 INFO - 'PWD': '/builds/slave/test', 16:28:02 INFO - 'SHELL': '/bin/bash', 16:28:02 INFO - 'SHLVL': '1', 16:28:02 INFO - 'TERM': 'linux', 16:28:02 INFO - 'TMOUT': '86400', 16:28:02 INFO - 'USER': 'cltbld', 16:28:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:02 INFO - '_': '/tools/buildbot/bin/python'} 16:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:02 INFO - Running setup.py (path:/tmp/pip-RbEZYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:02 INFO - Running setup.py (path:/tmp/pip-rSDCRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:02 INFO - Running setup.py (path:/tmp/pip-3Ah7mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:02 INFO - Running setup.py (path:/tmp/pip-21Bwfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:02 INFO - Running setup.py (path:/tmp/pip-ZLl5Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:02 INFO - Running setup.py (path:/tmp/pip-r6RNDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:02 INFO - Running setup.py (path:/tmp/pip-TNlG1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:02 INFO - Running setup.py (path:/tmp/pip-hZDVDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:02 INFO - Running setup.py (path:/tmp/pip-Lu8hYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:03 INFO - Running setup.py (path:/tmp/pip-RiOHEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:03 INFO - Running setup.py (path:/tmp/pip-iZneGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:03 INFO - Running setup.py (path:/tmp/pip-hTBEyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:03 INFO - Running setup.py (path:/tmp/pip-Fo1SPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:03 INFO - Running setup.py (path:/tmp/pip-fUpyI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:03 INFO - Running setup.py (path:/tmp/pip-gS9duN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:03 INFO - Running setup.py (path:/tmp/pip-PGXcdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:03 INFO - Running setup.py (path:/tmp/pip-7tM6oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:03 INFO - Running setup.py install for manifestparser 16:28:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:03 INFO - Running setup.py install for mozcrash 16:28:03 INFO - Running setup.py install for mozdebug 16:28:03 INFO - Running setup.py install for mozdevice 16:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for mozfile 16:28:04 INFO - Running setup.py install for mozhttpd 16:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for mozinfo 16:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for mozInstall 16:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for mozleak 16:28:04 INFO - Running setup.py install for mozlog 16:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for moznetwork 16:28:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for mozprocess 16:28:04 INFO - Running setup.py install for mozprofile 16:28:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:28:04 INFO - Running setup.py install for mozrunner 16:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:28:05 INFO - Running setup.py install for mozscreenshot 16:28:05 INFO - Running setup.py install for moztest 16:28:05 INFO - Running setup.py install for mozversion 16:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:28:05 INFO - Cleaning up... 16:28:05 INFO - Return code: 0 16:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28: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:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:05 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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:28:05 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:28:05 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:28:05 INFO - Using env: {'DISPLAY': ':0', 16:28:05 INFO - 'HOME': '/home/cltbld', 16:28:05 INFO - 'LANG': 'en_US.UTF-8', 16:28:05 INFO - 'LANGUAGE': 'en_US:en', 16:28:05 INFO - 'LOGNAME': 'cltbld', 16:28:05 INFO - 'MAIL': '/var/mail/cltbld', 16:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:05 INFO - 'MOZ_NO_REMOTE': '1', 16:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:05 INFO - 'NO_EM_RESTART': '1', 16:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:05 INFO - 'PWD': '/builds/slave/test', 16:28:05 INFO - 'SHELL': '/bin/bash', 16:28:05 INFO - 'SHLVL': '1', 16:28:05 INFO - 'TERM': 'linux', 16:28:05 INFO - 'TMOUT': '86400', 16:28:05 INFO - 'USER': 'cltbld', 16:28:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:05 INFO - '_': '/tools/buildbot/bin/python'} 16:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:05 INFO - Running setup.py (path:/tmp/pip-U3vvxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:05 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:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:05 INFO - Running setup.py (path:/tmp/pip-NIYIgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:05 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:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:05 INFO - Running setup.py (path:/tmp/pip-CEBwDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:05 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:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:05 INFO - Running setup.py (path:/tmp/pip-O2yAhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:05 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:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:05 INFO - Running setup.py (path:/tmp/pip-L3tZEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:05 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:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:05 INFO - Running setup.py (path:/tmp/pip-TeMQV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28: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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:06 INFO - Running setup.py (path:/tmp/pip-MSFmKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28: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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:06 INFO - Running setup.py (path:/tmp/pip-8UIbXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28: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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:06 INFO - Running setup.py (path:/tmp/pip-xOm3Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28: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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:06 INFO - Running setup.py (path:/tmp/pip-k908HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28: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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:06 INFO - Running setup.py (path:/tmp/pip-9yn_WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28: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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:06 INFO - Running setup.py (path:/tmp/pip-r_p2xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:06 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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:06 INFO - Running setup.py (path:/tmp/pip-nDq4Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:06 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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:06 INFO - Running setup.py (path:/tmp/pip-5Bi6RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:06 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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:06 INFO - Running setup.py (path:/tmp/pip-KUtsQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:06 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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:06 INFO - Running setup.py (path:/tmp/pip-rBtqd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:06 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:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:06 INFO - Running setup.py (path:/tmp/pip-Zii7ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:06 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:28:06 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:28:06 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:28:06 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:28:06 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:28:06 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:28:06 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:28:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:07 INFO - Downloading blessings-1.6.tar.gz 16:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:28:07 INFO - Installing collected packages: blessings 16:28:07 INFO - Running setup.py install for blessings 16:28:08 INFO - Successfully installed blessings 16:28:08 INFO - Cleaning up... 16:28:08 INFO - Return code: 0 16:28:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:08 INFO - Reading from file tmpfile_stdout 16:28:08 INFO - Current package versions: 16:28:08 INFO - argparse == 1.2.1 16:28:08 INFO - blessings == 1.6 16:28:08 INFO - blobuploader == 1.2.4 16:28:08 INFO - docopt == 0.6.1 16:28:08 INFO - functools32 == 3.2.3-2 16:28:08 INFO - jsonschema == 2.5.1 16:28:08 INFO - manifestparser == 1.1 16:28:08 INFO - mozInstall == 1.13 16:28:08 INFO - mozcrash == 1.0 16:28:08 INFO - mozdebug == 0.1 16:28:08 INFO - mozdevice == 0.51 16:28:08 INFO - mozfile == 1.2 16:28:08 INFO - mozhttpd == 0.7 16:28:08 INFO - mozinfo == 0.10 16:28:08 INFO - mozleak == 0.1 16:28:08 INFO - mozlog == 3.5 16:28:08 INFO - moznetwork == 0.27 16:28:08 INFO - mozprocess == 0.25 16:28:08 INFO - mozprofile == 0.28 16:28:08 INFO - mozrunner == 6.13 16:28:08 INFO - mozscreenshot == 0.1 16:28:08 INFO - mozsystemmonitor == 0.3 16:28:08 INFO - moztest == 0.8 16:28:08 INFO - mozversion == 1.4 16:28:08 INFO - psutil == 3.1.1 16:28:08 INFO - requests == 1.2.3 16:28:08 INFO - wsgiref == 0.1.2 16:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28: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:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28: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:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28: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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:28: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:28: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:28:08 INFO - Using env: {'DISPLAY': ':0', 16:28:08 INFO - 'HOME': '/home/cltbld', 16:28:08 INFO - 'LANG': 'en_US.UTF-8', 16:28:08 INFO - 'LANGUAGE': 'en_US:en', 16:28:08 INFO - 'LOGNAME': 'cltbld', 16:28:08 INFO - 'MAIL': '/var/mail/cltbld', 16:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:08 INFO - 'MOZ_NO_REMOTE': '1', 16:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:08 INFO - 'NO_EM_RESTART': '1', 16:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:08 INFO - 'PWD': '/builds/slave/test', 16:28:08 INFO - 'SHELL': '/bin/bash', 16:28:08 INFO - 'SHLVL': '1', 16:28:08 INFO - 'TERM': 'linux', 16:28:08 INFO - 'TMOUT': '86400', 16:28:08 INFO - 'USER': 'cltbld', 16:28:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:08 INFO - '_': '/tools/buildbot/bin/python'} 16:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:08 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:28:08 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:28:08 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:28:08 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:28:08 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:28:08 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:28:08 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:28:08 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:28:08 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:28:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:28:08 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:28:08 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:28:08 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:28:08 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:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:28:09 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:28:09 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:28:09 INFO - Installing collected packages: simplejson 16:28:09 INFO - Running setup.py install for simplejson 16:28:09 INFO - building 'simplejson._speedups' extension 16:28:09 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:28:10 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:28:10 INFO - Successfully installed simplejson 16:28:10 INFO - Cleaning up... 16:28:10 INFO - Return code: 0 16:28:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x12a41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16119c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, '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': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', '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:28:10 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:28:10 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:28:10 INFO - Using env: {'DISPLAY': ':0', 16:28:10 INFO - 'HOME': '/home/cltbld', 16:28:10 INFO - 'LANG': 'en_US.UTF-8', 16:28:10 INFO - 'LANGUAGE': 'en_US:en', 16:28:10 INFO - 'LOGNAME': 'cltbld', 16:28:10 INFO - 'MAIL': '/var/mail/cltbld', 16:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:10 INFO - 'MOZ_NO_REMOTE': '1', 16:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:10 INFO - 'NO_EM_RESTART': '1', 16:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:10 INFO - 'PWD': '/builds/slave/test', 16:28:10 INFO - 'SHELL': '/bin/bash', 16:28:10 INFO - 'SHLVL': '1', 16:28:10 INFO - 'TERM': 'linux', 16:28:10 INFO - 'TMOUT': '86400', 16:28:10 INFO - 'USER': 'cltbld', 16:28:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:10 INFO - '_': '/tools/buildbot/bin/python'} 16:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:28:11 INFO - Cleaning up... 16:28:11 INFO - Return code: 0 16:28:11 INFO - Running post-action listener: _resource_record_post_action 16:28:11 INFO - Running post-action listener: _start_resource_monitoring 16:28:11 INFO - Starting resource monitoring. 16:28:11 INFO - [mozharness: 2017-09-22 23:28:11.072379Z] Finished create-virtualenv step (success) 16:28:11 INFO - [mozharness: 2017-09-22 23:28:11.072858Z] Running install step. 16:28:11 INFO - Running pre-action listener: _resource_record_pre_action 16:28:11 INFO - Running main action method: install 16:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:11 INFO - Reading from file tmpfile_stdout 16:28:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:28:11 INFO - Reading from file tmpfile_stdout 16:28:11 INFO - Output received: 16:28:11 INFO - Usage: mozinstall [options] installer 16:28:11 INFO - Options: 16:28:11 INFO - -h, --help show this help message and exit 16:28:11 INFO - -d DEST, --destination=DEST 16:28:11 INFO - Directory to install application into. [default: 16:28:11 INFO - "/builds/slave/test"] 16:28:11 INFO - --app=APP Application being installed. [default: firefox] 16:28:11 INFO - mkdir: /builds/slave/test/build/application 16:28:11 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:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:28:29 INFO - Reading from file tmpfile_stdout 16:28:29 INFO - Output received: 16:28:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:28:29 INFO - Running post-action listener: _resource_record_post_action 16:28:29 INFO - [mozharness: 2017-09-22 23:28:29.073231Z] Finished install step (success) 16:28:29 INFO - [mozharness: 2017-09-22 23:28:29.073485Z] Running setup-mitmproxy step. 16:28:29 INFO - Running pre-action listener: _resource_record_pre_action 16:28:29 INFO - Running main action method: setup_mitmproxy 16:28:29 INFO - Skipping: mitmproxy is not required 16:28:29 INFO - Running post-action listener: _resource_record_post_action 16:28:29 INFO - [mozharness: 2017-09-22 23:28:29.074627Z] Finished setup-mitmproxy step (success) 16:28:29 INFO - [mozharness: 2017-09-22 23:28:29.074917Z] Running run-tests step. 16:28:29 INFO - Running pre-action listener: _resource_record_pre_action 16:28:29 INFO - Running pre-action listener: _set_gcov_prefix 16:28:29 INFO - Running main action method: run_tests 16:28:29 WARNING - Try message not found. 16:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:28:29 INFO - Python 2.7.3 16:28:29 INFO - Return code: 0 16:28:29 INFO - grabbing minidump binary from tooltool 16:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:29 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 0x160ed60>, '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 0x160fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160fef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:28:29 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:28:29 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:28:29 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:28:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:28:29 INFO - Return code: 0 16:28:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:28:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:28:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:28:29 INFO - ENV: RUST_BACKTRACE is now full 16:28:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:28:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:28:29 INFO - Using env: {'DISPLAY': ':0', 16:28:29 INFO - 'HOME': '/home/cltbld', 16:28:29 INFO - 'LANG': 'en_US.UTF-8', 16:28:29 INFO - 'LANGUAGE': 'en_US:en', 16:28:29 INFO - 'LOGNAME': 'cltbld', 16:28:29 INFO - 'MAIL': '/var/mail/cltbld', 16:28:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:28:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:29 INFO - 'MOZ_NO_REMOTE': '1', 16:28:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:29 INFO - 'NO_EM_RESTART': '1', 16:28:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:29 INFO - 'PWD': '/builds/slave/test', 16:28:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:28:29 INFO - 'RUST_BACKTRACE': 'full', 16:28:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:28:29 INFO - 'SHELL': '/bin/bash', 16:28:29 INFO - 'SHLVL': '1', 16:28:29 INFO - 'TERM': 'linux', 16:28:29 INFO - 'TMOUT': '86400', 16:28:29 INFO - 'USER': 'cltbld', 16:28:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:29 INFO - '_': '/tools/buildbot/bin/python'} 16:28:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:28:29 INFO - mozversion application_buildid: 20170922215617 16:28:29 INFO - mozversion application_changeset: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 16:28:29 INFO - mozversion application_display_name: Nightly 16:28:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:28:29 INFO - mozversion application_name: Firefox 16:28:29 INFO - mozversion application_remotingname: firefox 16:28:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:28:29 INFO - mozversion application_vendor: Mozilla 16:28:29 INFO - mozversion application_version: 58.0a1 16:28:29 INFO - mozversion platform_buildid: 20170922215617 16:28:29 INFO - mozversion platform_changeset: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 16:28:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:28:29 INFO - mozversion platform_version: 58.0a1 16:28:29 INFO - using testdate: 1506122909 16:28:29 INFO - actual date: 1506122909 16:28:29 INFO - starting webserver on 'localhost:59144' 16:28:29 INFO - SUITE-START | Running 2 tests 16:28:29 INFO - TEST-START | dromaeo_css 16:28:29 INFO - Initialising browser for dromaeo_css test... 16:28:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59144/getInfo.html -profile /tmp/tmpdnARMr/profile 16:28:29 INFO - TEST-INFO | started process 22224 (/builds/slave/test/build/application/firefox/firefox http://localhost:59144/getInfo.html) 16:28:35 INFO - TEST-INFO | 22224: exit 0 16:28:35 INFO - Browser initialized. 16:28:35 INFO - Running cycle 1/1 for dromaeo_css test... 16:28:35 INFO - Using env: {'DISPLAY': ':0', 16:28:35 INFO - 'HOME': '/home/cltbld', 16:28:35 INFO - 'JSGC_DISABLE_POISONING': '1', 16:28:35 INFO - 'LANG': 'en_US.UTF-8', 16:28:35 INFO - 'LANGUAGE': 'en_US:en', 16:28:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:28:35 INFO - 'LOGNAME': 'cltbld', 16:28:35 INFO - 'MAIL': '/var/mail/cltbld', 16:28:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:28:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:28:35 INFO - 'MOZ_CRASHREPORTER': '1', 16:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:28:35 INFO - 'MOZ_NO_REMOTE': '1', 16:28:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:28:35 INFO - 'NO_EM_RESTART': '1', 16:28:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:35 INFO - 'PWD': '/builds/slave/test', 16:28:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:28:35 INFO - 'RUST_BACKTRACE': 'full', 16:28:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:28:35 INFO - 'SHELL': '/bin/bash', 16:28:35 INFO - 'SHLVL': '1', 16:28:35 INFO - 'STYLO_FORCE_DISABLED': '1', 16:28:35 INFO - 'TERM': 'linux', 16:28:35 INFO - 'TMOUT': '86400', 16:28:35 INFO - 'USER': 'cltbld', 16:28:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:35 INFO - '_': '/tools/buildbot/bin/python'} 16:28:35 INFO - TEST-INFO | started process 22462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdnARMr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:36 INFO - PID 22462 | 16:28:36 INFO - PID 22462 | (/builds/slave/test/build/application/firefox/firefox:22512): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:28:36 INFO - PID 22462 | 16:28:46 INFO - PID 22462 | RSS: Main: 141275136 16:28:46 INFO - PID 22462 | 16:31:43 INFO - PID 22462 | Cycle 1(1): loaded http://localhost:59144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59144/tests/dromaeo/cssquery-ext.html) 16:31:44 INFO - PID 22462 | RSS: Main: 146276352 16:31:44 INFO - PID 22462 | 16:34:46 INFO - PID 22462 | Cycle 1(1): loaded http://localhost:59144/tests/dromaeo/cssquery-ext.html (next: http://localhost:59144/tests/dromaeo/cssquery-jquery.html) 16:34:47 INFO - PID 22462 | RSS: Main: 146669568 16:34:47 INFO - PID 22462 | 16:37:48 INFO - PID 22462 | Cycle 1(1): loaded http://localhost:59144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59144/tests/dromaeo/cssquery-mootools.html) 16:37:49 INFO - PID 22462 | RSS: Main: 147419136 16:37:49 INFO - PID 22462 | 16:40:50 INFO - PID 22462 | Cycle 1(1): loaded http://localhost:59144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59144/tests/dromaeo/cssquery-prototype.html) 16:40:51 INFO - PID 22462 | RSS: Main: 147251200 16:40:51 INFO - PID 22462 | 16:43:54 INFO - PID 22462 | Cycle 1(1): loaded http://localhost:59144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59144/tests/dromaeo/cssquery-yui.html) 16:43:55 INFO - PID 22462 | RSS: Main: 146817024 16:43:55 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | Cycle 1(1): loaded http://localhost:59144/tests/dromaeo/cssquery-yui.html (next: http://localhost:59144/tests/dromaeo/cssquery-dojo.html) 16:46:56 INFO - PID 22462 | RSS: Main: 150138880 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | __start_tp_report 16:46:56 INFO - PID 22462 | _x_x_mozilla_page_load 16:46:56 INFO - PID 22462 | _x_x_mozilla_page_load_details 16:46:56 INFO - PID 22462 | |i|pagename|runs| 16:46:56 INFO - PID 22462 | |0;dojo.html;3840.788756618386;3897.337452633053;3910.8826735197936;3935.488386509753;3945.9802700986525;6257.37426257374;6332.683365831702;6371.617702937821;6403.839904002402;6409.935900640992;6342.365763423655;6387.041943708446;6392.680365981706;6418.069379939918;6490.383413575714;5735.426457354273;5764.164196191549;5810.448007439297;5828.795992140276;5851.180834683148;64.70364436806538;5739.856503587402;5765.68288744121;5857.121431785245;5877.382874798149;5411.350637923435;5725.770969161229;5739.282589676291;5773.855653608652;5833.212516310286;5708.029634962067;5733.967786250418;5801.24583804107;5813.186153938452;5828.446297601721;5634.859128521779;5666.801661941853;5769.0192667246665;5781.075027995543;5796.478316951495;6263.34234905333;6354.3010268870385;6429.196350456193;6438.034294855763;6443.774467893648;6652.733890644368;6857.485688573327;6903.033575299462;6947.235804061549;7025.156981162242;6967.965160174217;7053.047838541783;7057.435405167575;7059.682314295869;7063.823404414879;6380.7128679209545;6488.188976377953;6495.05821655862;6502.992036234391;6516.1203237562795;7105;7109.182444019004;7196.604186769726;7202.099737532809;7217.06178196831;6804;6812.420944219698;6877.862442751117;6882.518223724392;6921.7231310747;6757;6877.071595334666;6930.826729331706;7011.6494175292055;7012.439004879598;6879.2432832388395;6952.582845029315;6985.79042628722;6993;7004;6900.482463815234;6918.06606108179;6987.336203060701;7009.492959013836;7012.158540975116;4942.629302802232;5008.123578373843;5008.17365134756;5012.674176178537;5016.423111342169;4531.796069176895;4611;4617.468991066004;4671.065786842645;4702.435707715096;6373.490120790326;6378.394052564999;6432.324605916405;6448.613083215022;6456;6771.830704232433;6851.520393572402;6926.896096558556;6956.582605043714;6977.89533157003;6285.308616052231;6414.166158399378;6426.1003459515705;6436.678166091677;6453.935460645427;5577.776888924398;5584.134459158756;5638.069718496484;5661.2923384576925;5676.460736230051;7030.578165309996;7208.2791720828545;7228.927710722931;7315.963420182971;7322.780316590511;6826.419754320938;6849.828754280983;6868.828279292958;6949.339812717783;6952.165740111219;7121.252268511939;7232.42140628759;7296.270372962661;7313.634318283958;7318.3047610476915;6845.897311540431;6862.794116176523;6867.896981545381;6952.096227490596;6963.825904352431;6811.8978215325815;6845.760398386033;6858.314168583302;6865.588064716133;6885.277045910308;6638.037484564615;6645.800625981228;6692.464602831665;6773.796786096425;6785.660716964033;6621.039949207434;6664.133662623828;6744.022116793136;6745.392914637706;6759.86480270382;6582.506312026521;6622.768203112868;6683.13119294508;6684.498662600422;6716.764913228014;6632.4694024478895;6677.399034086956;6694.163229596301;6723.2940541244425;6832.316768323128;6453.257875344396;6507.511936604679;6525.184351956005;6533.542652014314;6551.50863685216 16:46:56 INFO - PID 22462 | |1;ext.html;915.3683958068937;916.399758158406;948.8434408322627;984.6602921991913;984.7636567223864;43367.78316108419;44050.559494405046;44202.557974420284;44239.33640995384;44246.336304955454;41148;41486.17027659452;41591.58408415915;41615.58384416155;41713;7644.617769111536;7735.033120859893;7742.303192712655;7751.806204844896;7781.610919454005;7595.81010474737;7661.502002369856;7716.266954639328;7732.961335193344;7740.380769538423;8365.832683346329;8574.228319451247;8575.099614540477;8582.613782379776;8603.655853765842;8433.873491897626;8513.829723405528;8522.659093636246;8525.232729054353;8528.275096616795;8197.549134797584;8432.494050356936;8435.915640843574;8440.535770532619;8460.365472589581;40079;40353.596464035276;40362;40383.39424908629;40406.59593404087;3650.361186792301;3696.2053158571034;3699.7965111918834;3710.239400922804;3711.77729336238;33263.33473330544;33385;33395.16512087193;33412.6658733412;33419;5482.671039737588;5487.725613719338;5488.4237155098535;5501.587380946445;5514.558835293207;220204;220537;221017;221188;221872.8906355474;51949.7402512985;52570.47429525732;54806.45193548093;55548.16677749837;55755;58836.411635883094;58915;59094.40905590975;59306;59327;17064.2321095551;17156.485305440856;17187;17308.307667693403;17497;14052.859471405154;14160.716785664436;14192.432302707983;14194.787078193835;14196.929015354857;15596.376144954302;15608.921955390377;15658.843411565966;15664.608384790243;15674.012358260181;6129.601575897553;6228.532860035515;6257.937420625826;6273.905891411632;6335.778247761306;1102.6967583914488;1112.5104953820294;1119.9608013719644;1122.2761318949233;1122.5678113926197;26457.31421796709;26471.47057058848;26618.20145395641;26670;26717.866410667822;1197.8802119788127;1203.12172114357;1214.5081242096965;1220.951161953512;1234.0312854409246;13888.722225555432;13933;14121.364538595788;14255;14301;283677;283755;283797;286078;286699;58219;61139.38860611426;61659.383406166264;62118.68940655268;62132;1514.4320879670124;1537.3389442539815;1556.2374436526247;1567.1145802621481;1568.8509591588781;30869.382612348076;30928;31146.53280200844;31227.063188104392;31843.681563184073;42902.14195716131;43214.78392608017;43322.566774331855;43353;43365.566344336155;254263;254328;254731;254796;255365;36697.44953825748;36952;37572.62427375691;37588;38443.80778096092;46179.30731039104;47919.28121078117;47998.280025798944;48509.5149048505;48623.27065093956;34297.657023430445;34462.310753785285;34677.65322346845;34748.82625586856;34762.13094672552;34341.828290858386;34590.481142783385;34679.13302167466;34990.47514287339;35126.473102902964;39038.804805975786;40241;40374;40423.59576404316;40667.59332406638;33360.66639333672;33469.66530334763;33528.832355838065;33774.831125845194;34139.97580072602;24857.87571062133;25993;26354.86822565875;26466.941322347662;26646.46707065809 16:46:56 INFO - PID 22462 | |2;jquery.html;619.4146531527708;624.4848000399671;627.5356236385073;635.114015947753;646.5183438338437;23179.420514487127;23817.76182238177;23999.64000539991;24016.639750403716;24042.39894002651;25067.62398564023;26457.20628381147;26496.86751566244;26508.734912650867;26532.33669158272;5995.640261584297;6008.489278411318;6011.519078473733;6035.215421995134;6035.245594300713;6698.698558564852;6946.444284457231;6962.094927659397;6974;6993.545419547739;6944.756933507303;6978.9302106978785;6979.685914133876;6980.9301906981045;6982.441404687638;6651.301613330603;6899.827504312382;6913.170419549636;6918.238993710688;6919.4464442844455;6375.2668443128705;6388.7125079371535;6455.257645370795;6460.870782584322;6473.320301368382;30690.846545767352;31066.689333106606;31114.53328200079;31268.37463250745;31312.21719457009;2115.132795553831;2164.7835216478384;2197.6703494475796;2197.6923230747707;2199.4611320226645;20076.49808754778;20829.270975515785;20834.791652083437;20850.374488765363;20930.476738081517;2539.7968162546954;2563.2950938491877;2614.3856193794445;2628.093307808803;2631.0528209844633;124201;133493;134460.32769836186;148458.25770871184;159460;15357.078575285519;16123.435679751152;16447.91776041112;16664.41674541385;16731.6653666926;26033.73966260351;26230.34424139412;26265.73734262633;26298.737012630012;26368.20895373142;10262.43556604379;10299;10473.423961682029;10514.789704206027;10524.52639631203;9238.907610923805;9242.146022114945;9323.953380233192;9336.57985390659;9362.531873406302;9795.657151999645;9833.213342932548;9892.703218903445;10099.343542669703;10208.336458130347;2784.832910025405;2805.088346287465;2820.576913462997;2828;2877.9424411511654;987.2151639446657;993.3195760903805;1004.347174336687;1009.5204777730667;1017.4302390661253;20339;20545.794542054387;20714.17143314281;20901.581968360548;20990.68513972261;1054.9894501054891;1063.250408462048;1064.1008347945974;1068.7488440216698;1074.7366895110747;11389.65831025054;11615.303081815118;11655.417229138679;11757.823632645517;11793.233439826556;534073;550215;552445;558611;559775;128745;128787;130008;132135.33932330276;133198;1234.8456442944632;1246.0779023522527;1275.5599318235195;1324.503311258259;1334.0261609025272;22792;22831.543369132192;23170.536589268457;23262.3021309361;23386.64920026167;62038.37961620326;63362.683186583774;65016;65743;66333;77510.2248977503;77780.61109694415;77980.61009694915;78076;78387.60806195933;15786.68426631484;16199.352025918832;16282.185890705654;16283.59291017734;16292;24005;24278.27165185047;24297.878510607334;24551.75448245566;24633.753662463147;20228.494287642927;20273.695894561297;20274.189032439128;20320.695189571874;20546.178152874316;17293.308267669654;17359.91320043442;17465.738013930055;17972.460826175236;17994;18619.906900465412;18663.44009679712;20568;20852.895735521226;20867.06098225553;15790;15863.52409427719;15907;16008.35966561371;16026.839731603;19225.13486893121;19389.903050484656;19514.707279391103;19604.411867643994;19628.116734747255 16:46:56 INFO - PID 22462 | |3;mootools.html;1441.4810668159464;1540.8690261327786;1554.2151213637112;1556.595285225841;1560.9141497217656;17650.11749412529;18065;18103.909480452614;18123.637527249448;18128.728069078974;17675.82324176761;17682.911585442056;17690.911545442254;17693.734593981102;17777;2870.225039239404;2921.24047747585;2925.970740292602;2927.0633397312868;2934.750546203575;2782.3044238940265;2828.7595554377904;2831.7593004594632;2856.0289501569464;2857.1571386440946;2749.2439579115703;2829.688734239232;2829.915102546927;2835.206142280165;2835.234486688593;2679.8124131310815;2737.438825040862;2759.503289407916;2759.889604415821;2761.226856480179;2664.280644226048;2707.945841083167;2709.4851978124093;2710.0514819813106;2710.688270848858;16340.428085017085;16692.83307166925;16693.332266709316;16713.49859504217;16722.58193545171;8520.957395212985;8744.431611945203;8839.823203535892;8893.510856902867;8899.822003559893;5267.789288428458;5524.613277070606;5553;5584.6090773645865;5735.770569177228;2073.170731707314;2134.7224860768;2167.4039639099374;2180.8364372672113;2198.2525941179915;30916.53625195624;31006.224844378845;31093.689063109305;31103.066907992797;31130.688693113007;6871.278515755874;7144.3212894774915;7814.4529882907655;7969.8406031880195;8041.075276343178;23173.652395214085;23251.18620848296;23417.648735268984;23438.765612344;23572.29283121509;8865.335099867536;8935.419197752126;8955.41789783662;9001.684941027033;9004.954975225082;7838.960805196051;8067.475614085066;8107.351411887035;8117.918820811835;8129.268365847102;6193.535484838655;6242.15730876335;6246.875062498724;6290.433860952445;6343.1436756038265;1897.345415831536;1932.2753967262277;1961.4115765270362;1964.0670681426209;1971.0735954101835;919.7516670498928;944.0417975754615;946.6450081219542;947.5072962059828;948.5968463403026;9363.765905852408;9482.478463684425;9691.9030809691;9721.902780972241;9764.121229089416;786.5320134519951;794.5312265763112;800.1438460846838;800.4876878797575;811.853866304071;5422.457754224546;5452.182172674131;5502.532284755761;5507.4767897050515;5528.806491772769;24392.146274880295;24778.752212478004;25393.11124110647;25413.364665883502;25428.237152885442;25015.499690006098;25196.874015629804;25198.24405267845;25199.62200566993;25278.36804079876;11240.606578769704;12192.329421881881;12197.451114699683;12376.876231237753;12406.193597416139;10021.148202402877;10039.799204015733;10056.195504359488;10074.244431667508;10075.496225188564;20905.89547052316;21390.893045534674;21457.03443345022;21790.128394864027;21819;22018.33944981589;22086.558268834855;22149.003294852093;22435.551288974457;22473.43816404603;13827.516036939061;14053.086549374259;14061.859381406464;14062.648433789238;14073;15909.761353579937;15936.36254549805;16057.678846422772;16208.10855402917;16220.51338459848;12673.8098928518;12690.302033388252;12701.047421443243;13028.739425211632;13095.541656041993;12228.327441990776;12335.321557314433;12389.690257743629;12408.937955310166;12689.873101269239;10652.786944260917;10711;10793.784124317626;10903.073238774792;10910.509027093958;8729.170728780755;8734;8787.736367908972;8853.822923541622;8883.600237989176;8538.530380829114;8619.353548483763;8647.178518040777;8701.303895688456;8780.868286975829 16:46:56 INFO - PID 22462 | |4;prototype.html;529.1639210048124;551.2337850387961;561.2619405481794;568.0910543130993;585.5257241634276;6147.846303842406;6245.531585131122;6250.9062364064575;6278.434940855322;6285.5914365566205;6239.937600624004;6257.124002639634;6275.6548389838545;6301.621902685831;6315.873682526347;4891.4130304363525;5017.67385119966;5038.748062596856;5172.431032586413;5236.528712415882;5065.721385323805;5095.847124586268;5116;5117.309163262949;5122.692638441706;5039.496050394968;5045.369328833895;5052.646314757969;5071.3407257056715;5076.670016448919;4995.450500444948;5053.6860416291665;5054.216596427523;5066.949330506703;5098.209777484459;4579.152856721517;4628.606568441686;4630.351750754863;4635.351050852883;4651.488336283006;6094.360092190301;6113.449789518964;6115.724792384353;6131.14164017038;6206.689665516707;5777.422257774231;5816.975172910105;5856.238688970449;5871.823845284648;5876.177335173079;6623.437007854338;6634.9715794052;6642.269350371455;6667.233268174125;6723.495737819683;5086.415062267813;5093.006863661588;5095.108356037678;5124.76938537763;5143.562797162245;6886.793396198122;6985.685644146026;7057.2356910772305;7069.399101076363;7074.7877563672655;5268.78924843002;5275.261463395128;5275.5515781158265;5280.683159010472;5292.603054770831;5303.734813259399;5321.414644389114;5352.946470535323;5373.543248823816;5440.129579267298;5854.970725146347;5863.20846685692;5889.793857214977;5898.351181370046;5910.586258961917;6283.340249273851;6322.873542529215;6518.57629254097;6560.934390656128;6588.374104460068;1805.9187336569885;1827.570520927581;1830.3593742190126;1837.7059670452663;1848.4731851422548;1226.405193481161;1294.6310301564008;1315.224017829485;1317.3610798762593;1330.6074707961175;5983.700814959235;6170.382961703794;6173.660448675366;6176.227971503562;6192.195014648067;6658.966705166443;6677.699503522354;6682.331766823376;6703.262641109474;6711.832204194934;6145.723442445012;6190.628562286187;6192.349803270682;6210.968945155336;6219.782307619212;3498.5626796650417;3550.715942724576;3557.1462848916076;3557.626449222846;3567.304375646776;6934.271901450376;7022.578645281299;7025.367716905503;7046.964765176142;7075.363217310467;6858.417034552119;6872.896906546406;6924.88380228899;6986.755463558751;7005.614691191931;7070.116235470567;7093.680784364716;7100.609466479394;7121.35907768293;7123.786286411416;6629.370209830058;6683.331666833278;6698.363655452919;6762.966185169043;6789;6700.229473610597;6710.328967103446;6715.496337774589;6751.898721519279;6796.320367963164;7046.907729301966;7081.610511421921;7132.251113633201;7139.928600713926;7150.427965762622;5201.583873290052;5240.423553409199;5244.160934250502;5264.73676316175;5286.418493965583;6754.86490270182;6788.898166527605;6821.522493425413;6836.829079273058;6882.69027893736;6604.867902642017;6612.867742645217;6634.635095069818;6664.900026499509;6678.599284042973;6421.068945003042;6520.739170433129;6538.215414150142;6546.312637173029;6584.144061272004;6426.485881129592;6454.838629034311;6513.4463570595135;6517.3808488193545;6528.445082168069;6110.205673262448;6502.139058814107;6594.208694956636;6609.966950165219;6627.768028118992;6310;6350.174477317919;6391;6394.488440924808;6426.871462570629 16:46:56 INFO - PID 22462 | |5;yui.html;976.5019839881662;991.1971303244372;1005.2711783956632;1015.1168483419426;1020.2705065877898;19109.808901910976;19161.61676766464;19167.616647667037;19322.71015934762;19348.70976935347;17383.304667813303;17501.649967000652;17551.82448175518;19151.521211969706;19642.410727678158;1036.1037702387418;1055.9260851740382;1056.2922841696081;1057.788442311537;1061.029158320136;1070.4433694478867;1070.550368845083;1071.0200166847326;1071.1377341240297;1072.0458791675414;1119.7368618374676;1155.8901904319075;1159.1016961854546;1159.4782347943417;1159.907207423404;1154.0306142840054;1154.2266681323492;1154.4747140051256;1159;1163.4764356039816;780.3211206250542;801.9759407217792;808.127222599591;823.9134890836435;829.0755807274905;20810;20939.68590471144;21014.474638134016;21063.262785802424;21091.15635374583;22197.667034994487;22519.549609007892;22961.54076918452;23028.078876844906;23050.53898922029;17881.821181788146;17882.642347152985;17997.820021799744;18014.189361478766;18145.81854181468;3862.5558060822805;3904.12157264616;3908.2965066288057;3920.5099362579676;3924.1170736584327;126685;160753.19623401808;163962;164226;165341.17329413275;18457.261709531736;18473.81526184721;19056.809431905782;19183.52041198953;19196.328128515433;34688.479672804926;34813.30373392518;34966.12584685352;35034.82482587571;35336.64663353334;9881.407115573089;9889.80220395588;9963.153131983863;9963.601455941682;9987.051230133126;4247.702660813775;4347.108842687241;4365.738055716667;4449.421575195269;4478.57453541913;5919.4968427684125;6034.064719968412;6034.426729460694;6056.9697151513965;6067.7864427114755;1242.589945318043;1280.4238092858252;1285.9357032148355;1286.3503930515217;1287.2598256002836;736.131364989307;751.5265382808905;755.9584222867795;767.2327672327673;775.4339332287461;12776.488940442465;12819.16675416095;13862.792058119136;14462.20457874806;14534.127952322682;728.5847067171661;728.6866647341589;728.7085165933563;739.2459691115032;742.5767312631748;6235.220597425322;6299.401556852092;6325.9051114233325;6381.1066450696935;6456.54804163704;144802;147899;149262.1033055373;150432;152044;100991.63309575504;125650;127129;129744;132896;111116;111267;111498;111672;112086.43956780164;14636.41454341857;14680.265986700835;14719.92640036793;14797.704045919236;14994.775078374052;51609.74195129;51636;51760;53127.468725313796;53785;68887.3111268901;69804.65097674682;70160.64919675369;70177.64911175412;70197;19308.13113409872;19720.11259493355;19947.401577952685;19960.90215038187;20162.395128146178;21310.147594096063;21438.356849294545;21444;21627.567448650625;21704.782952170277;20114.09486573137;20331;20359.287424940056;20381.79618203799;20457.07943142592;18975.715364269825;19095;19097.809021909605;19163.32928347501;19244.23023079061;17968.19143138588;17981.460556183334;18116.27534898589;18157.27370905149;18157.54606134857;14772.48296309624;14942.925285373503;14961.700765984402;15097.698046039237;15140.772888406904;14316.355763990437;14349.067310624776;14375.568732938029;14591;14844.925775371054 16:46:56 INFO - PID 22462 | __end_tp_report 16:46:56 INFO - PID 22462 | __start_cc_report 16:46:56 INFO - PID 22462 | _x_x_mozilla_cycle_collect,271 16:46:56 INFO - PID 22462 | __end_cc_report 16:46:56 INFO - PID 22462 | __startTimestamp1506124016756__endTimestamp 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | ------- Summary: start ------- 16:46:56 INFO - PID 22462 | Number of tests: 6 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | [#0] dojo.html Cycles:165 Average:6344.49 Median:6622.77 stddev:907.69 (13.7%) stddev-sans-first:888.97 16:46:56 INFO - PID 22462 | Values: 3840.8 3897.3 3910.9 3935.5 3946.0 6257.4 6332.7 6371.6 6403.8 6409.9 6342.4 6387.0 6392.7 6418.1 6490.4 5735.4 5764.2 5810.4 5828.8 5851.2 64.7 5739.9 5765.7 5857.1 5877.4 5411.4 5725.8 5739.3 5773.9 5833.2 5708.0 5734.0 5801.2 5813.2 5828.4 5634.9 5666.8 5769.0 5781.1 5796.5 6263.3 6354.3 6429.2 6438.0 6443.8 6652.7 6857.5 6903.0 6947.2 7025.2 6968.0 7053.0 7057.4 7059.7 7063.8 6380.7 6488.2 6495.1 6503.0 6516.1 7105.0 7109.2 7196.6 7202.1 7217.1 6804.0 6812.4 6877.9 6882.5 6921.7 6757.0 6877.1 6930.8 7011.6 7012.4 6879.2 6952.6 6985.8 6993.0 7004.0 6900.5 6918.1 6987.3 7009.5 7012.2 4942.6 5008.1 5008.2 5012.7 5016.4 4531.8 4611.0 4617.5 4671.1 4702.4 6373.5 6378.4 6432.3 6448.6 6456.0 6771.8 6851.5 6926.9 6956.6 6977.9 6285.3 6414.2 6426.1 6436.7 6453.9 5577.8 5584.1 5638.1 5661.3 5676.5 7030.6 7208.3 7228.9 7316.0 7322.8 6826.4 6849.8 6868.8 6949.3 6952.2 7121.3 7232.4 7296.3 7313.6 7318.3 6845.9 6862.8 6867.9 6952.1 6963.8 6811.9 6845.8 6858.3 6865.6 6885.3 6638.0 6645.8 6692.5 6773.8 6785.7 6621.0 6664.1 6744.0 6745.4 6759.9 6582.5 6622.8 6683.1 6684.5 6716.8 6632.5 6677.4 6694.2 6723.3 6832.3 6453.3 6507.5 6525.2 6533.5 6551.5 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | [#1] ext.html Cycles:180 Average:43659.63 Median:3711.01 stddev:66260.44 (1785.5%) stddev-sans-first:66368.59 16:46:56 INFO - PID 22462 | Values: 915.4 916.4 948.8 984.7 984.8 43367.8 44050.6 44202.6 44239.3 44246.3 41148.0 41486.2 41591.6 41615.6 41713.0 7644.6 7735.0 7742.3 7751.8 7781.6 7595.8 7661.5 7716.3 7733.0 7740.4 8365.8 8574.2 8575.1 8582.6 8603.7 8433.9 8513.8 8522.7 8525.2 8528.3 8197.5 8432.5 8435.9 8440.5 8460.4 40079.0 40353.6 40362.0 40383.4 40406.6 3650.4 3696.2 3699.8 3710.2 3711.8 33263.3 33385.0 33395.2 33412.7 33419.0 5482.7 5487.7 5488.4 5501.6 5514.6 220204.0 220537.0 221017.0 221188.0 221872.9 51949.7 52570.5 54806.5 55548.2 55755.0 58836.4 58915.0 59094.4 59306.0 59327.0 17064.2 17156.5 17187.0 17308.3 17497.0 14052.9 14160.7 14192.4 14194.8 14196.9 15596.4 15608.9 15658.8 15664.6 15674.0 6129.6 6228.5 6257.9 6273.9 6335.8 1102.7 1112.5 1120.0 1122.3 1122.6 26457.3 26471.5 26618.2 26670.0 26717.9 1197.9 1203.1 1214.5 1221.0 1234.0 13888.7 13933.0 14121.4 14255.0 14301.0 283677.0 283755.0 283797.0 286078.0 286699.0 58219.0 61139.4 61659.4 62118.7 62132.0 1514.4 1537.3 1556.2 1567.1 1568.9 30869.4 30928.0 31146.5 31227.1 31843.7 42902.1 43214.8 43322.6 43353.0 43365.6 254263.0 254328.0 254731.0 254796.0 255365.0 36697.4 36952.0 37572.6 37588.0 38443.8 46179.3 47919.3 47998.3 48509.5 48623.3 34297.7 34462.3 34677.7 34748.8 34762.1 34341.8 34590.5 34679.1 34990.5 35126.5 39038.8 40241.0 40374.0 40423.6 40667.6 33360.7 33469.7 33528.8 33774.8 34140.0 24857.9 25993.0 26354.9 26466.9 26646.5 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | [#2] jquery.html Cycles:180 Average:38112.14 Median:23602.21 stddev:92500.78 (391.9%) stddev-sans-first:92717.43 16:46:56 INFO - PID 22462 | Values: 619.4 624.5 627.5 635.1 646.5 23179.4 23817.8 23999.6 24016.6 24042.4 25067.6 26457.2 26496.9 26508.7 26532.3 5995.6 6008.5 6011.5 6035.2 6035.2 6698.7 6946.4 6962.1 6974.0 6993.5 6944.8 6978.9 6979.7 6980.9 6982.4 6651.3 6899.8 6913.2 6918.2 6919.4 6375.3 6388.7 6455.3 6460.9 6473.3 30690.8 31066.7 31114.5 31268.4 31312.2 2115.1 2164.8 2197.7 2197.7 2199.5 20076.5 20829.3 20834.8 20850.4 20930.5 2539.8 2563.3 2614.4 2628.1 2631.1 124201.0 133493.0 134460.3 148458.3 159460.0 15357.1 16123.4 16447.9 16664.4 16731.7 26033.7 26230.3 26265.7 26298.7 26368.2 10262.4 10299.0 10473.4 10514.8 10524.5 9238.9 9242.1 9324.0 9336.6 9362.5 9795.7 9833.2 9892.7 10099.3 10208.3 2784.8 2805.1 2820.6 2828.0 2877.9 987.2 993.3 1004.3 1009.5 1017.4 20339.0 20545.8 20714.2 20901.6 20990.7 1055.0 1063.3 1064.1 1068.7 1074.7 11389.7 11615.3 11655.4 11757.8 11793.2 534073.0 550215.0 552445.0 558611.0 559775.0 128745.0 128787.0 130008.0 132135.3 133198.0 1234.8 1246.1 1275.6 1324.5 1334.0 22792.0 22831.5 23170.5 23262.3 23386.6 62038.4 63362.7 65016.0 65743.0 66333.0 77510.2 77780.6 77980.6 78076.0 78387.6 15786.7 16199.4 16282.2 16283.6 16292.0 24005.0 24278.3 24297.9 24551.8 24633.8 20228.5 20273.7 20274.2 20320.7 20546.2 17293.3 17359.9 17465.7 17972.5 17994.0 18619.9 18663.4 20568.0 20852.9 20867.1 15790.0 15863.5 15907.0 16008.4 16026.8 19225.1 19389.9 19514.7 19604.4 19628.1 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | [#3] mootools.html Cycles:180 Average:10779.39 Median:2672.05 stddev:7969.16 (298.2%) stddev-sans-first:7960.64 16:46:56 INFO - PID 22462 | Values: 1441.5 1540.9 1554.2 1556.6 1560.9 17650.1 18065.0 18103.9 18123.6 18128.7 17675.8 17682.9 17690.9 17693.7 17777.0 2870.2 2921.2 2926.0 2927.1 2934.8 2782.3 2828.8 2831.8 2856.0 2857.2 2749.2 2829.7 2829.9 2835.2 2835.2 2679.8 2737.4 2759.5 2759.9 2761.2 2664.3 2707.9 2709.5 2710.1 2710.7 16340.4 16692.8 16693.3 16713.5 16722.6 8521.0 8744.4 8839.8 8893.5 8899.8 5267.8 5524.6 5553.0 5584.6 5735.8 2073.2 2134.7 2167.4 2180.8 2198.3 30916.5 31006.2 31093.7 31103.1 31130.7 6871.3 7144.3 7814.5 7969.8 8041.1 23173.7 23251.2 23417.6 23438.8 23572.3 8865.3 8935.4 8955.4 9001.7 9005.0 7839.0 8067.5 8107.4 8117.9 8129.3 6193.5 6242.2 6246.9 6290.4 6343.1 1897.3 1932.3 1961.4 1964.1 1971.1 919.8 944.0 946.6 947.5 948.6 9363.8 9482.5 9691.9 9721.9 9764.1 786.5 794.5 800.1 800.5 811.9 5422.5 5452.2 5502.5 5507.5 5528.8 24392.1 24778.8 25393.1 25413.4 25428.2 25015.5 25196.9 25198.2 25199.6 25278.4 11240.6 12192.3 12197.5 12376.9 12406.2 10021.1 10039.8 10056.2 10074.2 10075.5 20905.9 21390.9 21457.0 21790.1 21819.0 22018.3 22086.6 22149.0 22435.6 22473.4 13827.5 14053.1 14061.9 14062.6 14073.0 15909.8 15936.4 16057.7 16208.1 16220.5 12673.8 12690.3 12701.0 13028.7 13095.5 12228.3 12335.3 12389.7 12408.9 12689.9 10652.8 10711.0 10793.8 10903.1 10910.5 8729.2 8734.0 8787.7 8853.8 8883.6 8538.5 8619.4 8647.2 8701.3 8780.9 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | [#4] prototype.html Cycles:180 Average:5655.46 Median:6215.38 stddev:1571.13 (25.3%) stddev-sans-first:1527.69 16:46:56 INFO - PID 22462 | Values: 529.2 551.2 561.3 568.1 585.5 6147.8 6245.5 6250.9 6278.4 6285.6 6239.9 6257.1 6275.7 6301.6 6315.9 4891.4 5017.7 5038.7 5172.4 5236.5 5065.7 5095.8 5116.0 5117.3 5122.7 5039.5 5045.4 5052.6 5071.3 5076.7 4995.5 5053.7 5054.2 5066.9 5098.2 4579.2 4628.6 4630.4 4635.4 4651.5 6094.4 6113.4 6115.7 6131.1 6206.7 5777.4 5817.0 5856.2 5871.8 5876.2 6623.4 6635.0 6642.3 6667.2 6723.5 5086.4 5093.0 5095.1 5124.8 5143.6 6886.8 6985.7 7057.2 7069.4 7074.8 5268.8 5275.3 5275.6 5280.7 5292.6 5303.7 5321.4 5352.9 5373.5 5440.1 5855.0 5863.2 5889.8 5898.4 5910.6 6283.3 6322.9 6518.6 6560.9 6588.4 1805.9 1827.6 1830.4 1837.7 1848.5 1226.4 1294.6 1315.2 1317.4 1330.6 5983.7 6170.4 6173.7 6176.2 6192.2 6659.0 6677.7 6682.3 6703.3 6711.8 6145.7 6190.6 6192.3 6211.0 6219.8 3498.6 3550.7 3557.1 3557.6 3567.3 6934.3 7022.6 7025.4 7047.0 7075.4 6858.4 6872.9 6924.9 6986.8 7005.6 7070.1 7093.7 7100.6 7121.4 7123.8 6629.4 6683.3 6698.4 6763.0 6789.0 6700.2 6710.3 6715.5 6751.9 6796.3 7046.9 7081.6 7132.3 7139.9 7150.4 5201.6 5240.4 5244.2 5264.7 5286.4 6754.9 6788.9 6821.5 6836.8 6882.7 6604.9 6612.9 6634.6 6664.9 6678.6 6421.1 6520.7 6538.2 6546.3 6584.1 6426.5 6454.8 6513.4 6517.4 6528.4 6110.2 6502.1 6594.2 6610.0 6627.8 6310.0 6350.2 6391.0 6394.5 6426.9 16:46:56 INFO - PID 22462 | 16:46:56 INFO - PID 22462 | [#5] yui.html Cycles:180 Average:28097.79 Median:19165.47 stddev:41055.85 (214.2%) stddev-sans-first:41120.52 16:46:56 INFO - PID 22462 | Values: 976.5 991.2 1005.3 1015.1 1020.3 19109.8 19161.6 19167.6 19322.7 19348.7 17383.3 17501.6 17551.8 19151.5 19642.4 1036.1 1055.9 1056.3 1057.8 1061.0 1070.4 1070.6 1071.0 1071.1 1072.0 1119.7 1155.9 1159.1 1159.5 1159.9 1154.0 1154.2 1154.5 1159.0 1163.5 780.3 802.0 808.1 823.9 829.1 20810.0 20939.7 21014.5 21063.3 21091.2 22197.7 22519.5 22961.5 23028.1 23050.5 17881.8 17882.6 17997.8 18014.2 18145.8 3862.6 3904.1 3908.3 3920.5 3924.1 126685.0 160753.2 163962.0 164226.0 165341.2 18457.3 18473.8 19056.8 19183.5 19196.3 34688.5 34813.3 34966.1 35034.8 35336.6 9881.4 9889.8 9963.2 9963.6 9987.1 4247.7 4347.1 4365.7 4449.4 4478.6 5919.5 6034.1 6034.4 6057.0 6067.8 1242.6 1280.4 1285.9 1286.4 1287.3 736.1 751.5 756.0 767.2 775.4 12776.5 12819.2 13862.8 14462.2 14534.1 728.6 728.7 728.7 739.2 742.6 6235.2 6299.4 6325.9 6381.1 6456.5 144802.0 147899.0 149262.1 150432.0 152044.0 100991.6 125650.0 127129.0 129744.0 132896.0 111116.0 111267.0 111498.0 111672.0 112086.4 14636.4 14680.3 14719.9 14797.7 14994.8 51609.7 51636.0 51760.0 53127.5 53785.0 68887.3 69804.7 70160.6 70177.6 70197.0 19308.1 19720.1 19947.4 19960.9 20162.4 21310.1 21438.4 21444.0 21627.6 21704.8 20114.1 20331.0 20359.3 20381.8 20457.1 18975.7 19095.0 19097.8 19163.3 19244.2 17968.2 17981.5 18116.3 18157.3 18157.5 14772.5 14942.9 14961.7 15097.7 15140.8 14316.4 14349.1 14375.6 14591.0 14844.9 16:46:56 INFO - PID 22462 | -------- Summary: end -------- 16:46:56 INFO - PID 22462 | 16:46:57 INFO - TEST-INFO | 22462: exit 0 16:46:57 INFO - TEST-OK | dromaeo_css | took 1107937ms 16:46:57 INFO - TEST-START | kraken 16:46:57 INFO - Initialising browser for kraken test... 16:46:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59144/getInfo.html -profile /tmp/tmpv1JYA0/profile 16:46:57 INFO - TEST-INFO | started process 22833 (/builds/slave/test/build/application/firefox/firefox http://localhost:59144/getInfo.html) 16:47:02 INFO - TEST-INFO | 22833: exit 0 16:47:02 INFO - Browser initialized. 16:47:02 INFO - Running cycle 1/1 for kraken test... 16:47:02 INFO - Using env: {'DISPLAY': ':0', 16:47:02 INFO - 'HOME': '/home/cltbld', 16:47:02 INFO - 'JSGC_DISABLE_POISONING': '1', 16:47:02 INFO - 'LANG': 'en_US.UTF-8', 16:47:02 INFO - 'LANGUAGE': 'en_US:en', 16:47:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:47:02 INFO - 'LOGNAME': 'cltbld', 16:47:02 INFO - 'MAIL': '/var/mail/cltbld', 16:47:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:47:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:47:02 INFO - 'MOZ_CRASHREPORTER': '1', 16:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:47:02 INFO - 'MOZ_NO_REMOTE': '1', 16:47:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:02 INFO - 'NO_EM_RESTART': '1', 16:47:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:02 INFO - 'PWD': '/builds/slave/test', 16:47:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:47:02 INFO - 'RUST_BACKTRACE': 'full', 16:47:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:47:02 INFO - 'SHELL': '/bin/bash', 16:47:02 INFO - 'SHLVL': '1', 16:47:02 INFO - 'STYLO_FORCE_DISABLED': '1', 16:47:02 INFO - 'TERM': 'linux', 16:47:02 INFO - 'TMOUT': '86400', 16:47:02 INFO - 'USER': 'cltbld', 16:47:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656', 16:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:02 INFO - '_': '/tools/buildbot/bin/python'} 16:47:02 INFO - TEST-INFO | started process 23069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv1JYA0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:47:03 INFO - PID 23069 | 16:47:03 INFO - PID 23069 | (/builds/slave/test/build/application/firefox/firefox:23119): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:47:03 INFO - PID 23069 | 16:47:14 INFO - PID 23069 | RSS: Main: 144371712 16:47:14 INFO - PID 23069 | 16:47:16 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59144/tests/kraken/driver.html?testName=audio-beat-detection) 16:47:17 INFO - PID 23069 | RSS: Main: 151298048 16:47:17 INFO - PID 23069 | 16:47:20 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59144/tests/kraken/driver.html?testName=audio-dft) 16:47:20 INFO - PID 23069 | RSS: Main: 152555520 16:47:20 INFO - PID 23069 | 16:47:23 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59144/tests/kraken/driver.html?testName=audio-fft) 16:47:24 INFO - PID 23069 | RSS: Main: 147349504 16:47:24 INFO - PID 23069 | 16:47:26 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59144/tests/kraken/driver.html?testName=audio-oscillator) 16:47:26 INFO - PID 23069 | RSS: Main: 148201472 16:47:26 INFO - PID 23069 | 16:47:28 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:47:29 INFO - PID 23069 | RSS: Main: 148312064 16:47:29 INFO - PID 23069 | 16:47:32 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59144/tests/kraken/driver.html?testName=imaging-darkroom) 16:47:33 INFO - PID 23069 | RSS: Main: 148295680 16:47:33 INFO - PID 23069 | 16:47:36 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59144/tests/kraken/driver.html?testName=imaging-desaturate) 16:47:37 INFO - PID 23069 | RSS: Main: 149610496 16:47:37 INFO - PID 23069 | 16:47:40 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59144/tests/kraken/driver.html?testName=json-parse-financial) 16:47:40 INFO - PID 23069 | RSS: Main: 151334912 16:47:40 INFO - PID 23069 | 16:47:42 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:47:42 INFO - PID 23069 | RSS: Main: 151257088 16:47:42 INFO - PID 23069 | 16:47:44 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:47:45 INFO - PID 23069 | RSS: Main: 150986752 16:47:45 INFO - PID 23069 | 16:47:46 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:47:47 INFO - PID 23069 | RSS: Main: 148221952 16:47:47 INFO - PID 23069 | 16:47:50 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:47:50 INFO - PID 23069 | RSS: Main: 148348928 16:47:50 INFO - PID 23069 | 16:47:53 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:47:53 INFO - PID 23069 | RSS: Main: 148783104 16:47:53 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | Cycle 1(1): loaded http://localhost:59144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59144/tests/kraken/driver.html?testName=ai-astar) 16:47:55 INFO - PID 23069 | RSS: Main: 150519808 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | __start_tp_report 16:47:55 INFO - PID 23069 | _x_x_mozilla_page_load 16:47:55 INFO - PID 23069 | _x_x_mozilla_page_load_details 16:47:55 INFO - PID 23069 | |i|pagename|runs| 16:47:55 INFO - PID 23069 | |0;ai-astar;106;105;107;105;105;106;106;105;104;105 16:47:55 INFO - PID 23069 | |1;audio-beat-detection;112;113;116;114;116;113;112;137;110;112 16:47:55 INFO - PID 23069 | |2;audio-dft;163;162;162;163;161;164;165;163;162;168 16:47:55 INFO - PID 23069 | |3;audio-fft;73;73;73;75;73;75;73;73;73;73 16:47:55 INFO - PID 23069 | |4;audio-oscillator;78;78;78;78;77;77;77;77;78;76 16:47:55 INFO - PID 23069 | |5;imaging-gaussian-blur;113;114;113;115;113;114;114;114;114;114 16:47:55 INFO - PID 23069 | |6;imaging-darkroom;150;151;150;152;150;151;151;152;151;152 16:47:55 INFO - PID 23069 | |7;imaging-desaturate;94;94;94;94;94;95;95;95;94;94 16:47:55 INFO - PID 23069 | |8;json-parse-financial;47;44;44;43;42;44;42;43;43;42 16:47:55 INFO - PID 23069 | |9;json-stringify-tinderbox;35;35;35;35;34;36;36;35;34;35 16:47:55 INFO - PID 23069 | |10;stanford-crypto-aes;70;74;72;69;70;70;72;72;71;71 16:47:55 INFO - PID 23069 | |11;stanford-crypto-ccm;105;106;104;109;107;116;106;108;109;106 16:47:55 INFO - PID 23069 | |12;stanford-crypto-pbkdf2;156;149;153;153;152;150;150;154;154;155 16:47:55 INFO - PID 23069 | |13;stanford-crypto-sha256-iterative;67;65;62;60;59;61;64;61;65;61 16:47:55 INFO - PID 23069 | __end_tp_report 16:47:55 INFO - PID 23069 | __start_cc_report 16:47:55 INFO - PID 23069 | _x_x_mozilla_cycle_collect,710 16:47:55 INFO - PID 23069 | __end_cc_report 16:47:55 INFO - PID 23069 | __startTimestamp1506124075949__endTimestamp 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | ------- Summary: start ------- 16:47:55 INFO - PID 23069 | Number of tests: 14 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#0] ai-astar Cycles:10 Average:105.40 Median:105.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 16:47:55 INFO - PID 23069 | Values: 106.0 105.0 107.0 105.0 105.0 106.0 106.0 105.0 104.0 105.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:113.50 stddev:7.78 (6.9%) stddev-sans-first:8.15 16:47:55 INFO - PID 23069 | Values: 112.0 113.0 116.0 114.0 116.0 113.0 112.0 137.0 110.0 112.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 16:47:55 INFO - PID 23069 | Values: 163.0 162.0 162.0 163.0 161.0 164.0 165.0 163.0 162.0 168.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 16:47:55 INFO - PID 23069 | Values: 73.0 73.0 73.0 75.0 73.0 75.0 73.0 73.0 73.0 73.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 16:47:55 INFO - PID 23069 | Values: 78.0 78.0 78.0 78.0 77.0 77.0 77.0 77.0 78.0 76.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 16:47:55 INFO - PID 23069 | Values: 113.0 114.0 113.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 16:47:55 INFO - PID 23069 | Values: 150.0 151.0 150.0 152.0 150.0 151.0 151.0 152.0 151.0 152.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:47:55 INFO - PID 23069 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#8] json-parse-financial Cycles:10 Average:43.40 Median:43.50 stddev:1.51 (3.5%) stddev-sans-first:0.87 16:47:55 INFO - PID 23069 | Values: 47.0 44.0 44.0 43.0 42.0 44.0 42.0 43.0 43.0 42.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#9] json-stringify-tinderbox Cycles:10 Average:35.00 Median:35.00 stddev:0.67 (1.9%) stddev-sans-first:0.71 16:47:55 INFO - PID 23069 | Values: 35.0 35.0 35.0 35.0 34.0 36.0 36.0 35.0 34.0 35.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#10] stanford-crypto-aes Cycles:10 Average:71.10 Median:71.50 stddev:1.45 (2.0%) stddev-sans-first:1.48 16:47:55 INFO - PID 23069 | Values: 70.0 74.0 72.0 69.0 70.0 70.0 72.0 72.0 71.0 71.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#11] stanford-crypto-ccm Cycles:10 Average:107.60 Median:107.50 stddev:3.37 (3.1%) stddev-sans-first:3.44 16:47:55 INFO - PID 23069 | Values: 105.0 106.0 104.0 109.0 107.0 116.0 106.0 108.0 109.0 106.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:153.50 stddev:2.32 (1.5%) stddev-sans-first:2.11 16:47:55 INFO - PID 23069 | Values: 156.0 149.0 153.0 153.0 152.0 150.0 150.0 154.0 154.0 155.0 16:47:55 INFO - PID 23069 | 16:47:55 INFO - PID 23069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:2.59 (4.1%) stddev-sans-first:2.18 16:47:55 INFO - PID 23069 | Values: 67.0 65.0 62.0 60.0 59.0 61.0 64.0 61.0 65.0 61.0 16:47:55 INFO - PID 23069 | -------- Summary: end -------- 16:47:55 INFO - PID 23069 | 16:47:56 INFO - PID 23069 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:47:56 INFO - TEST-INFO | 23069: exit 0 16:47:56 INFO - TEST-OK | kraken | took 59286ms 16:47:56 INFO - SUITE-END | took 1167s 16:47:57 INFO - Completed test suite (00:19:27) 16:47:57 INFO - javascript benchmark 16:47:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9193.51350111331, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3840.788756618386, 3897.337452633053, 3910.8826735197936, 3935.488386509753, 3945.9802700986525, 6257.37426257374, 6332.683365831702, 6371.617702937821, 6403.839904002402, 6409.935900640992, 6342.365763423655, 6387.041943708446, 6392.680365981706, 6418.069379939918, 6490.383413575714, 5735.426457354273, 5764.164196191549, 5810.448007439297, 5828.795992140276, 5851.180834683148, 64.70364436806538, 5739.856503587402, 5765.68288744121, 5857.121431785245, 5877.382874798149, 5411.350637923435, 5725.770969161229, 5739.282589676291, 5773.855653608652, 5833.212516310286, 5708.029634962067, 5733.967786250418, 5801.24583804107, 5813.186153938452, 5828.446297601721, 5634.859128521779, 5666.801661941853, 5769.0192667246665, 5781.075027995543, 5796.478316951495, 6263.34234905333, 6354.3010268870385, 6429.196350456193, 6438.034294855763, 6443.774467893648, 6652.733890644368, 6857.485688573327, 6903.033575299462, 6947.235804061549, 7025.156981162242, 6967.965160174217, 7053.047838541783, 7057.435405167575, 7059.682314295869, 7063.823404414879, 6380.7128679209545, 6488.188976377953, 6495.05821655862, 6502.992036234391, 6516.1203237562795, 7105.0, 7109.182444019004, 7196.604186769726, 7202.099737532809, 7217.06178196831, 6804.0, 6812.420944219698, 6877.862442751117, 6882.518223724392, 6921.7231310747, 6757.0, 6877.071595334666, 6930.826729331706, 7011.6494175292055, 7012.439004879598, 6879.2432832388395, 6952.582845029315, 6985.79042628722, 6993.0, 7004.0, 6900.482463815234, 6918.06606108179, 6987.336203060701, 7009.492959013836, 7012.158540975116, 4942.629302802232, 5008.123578373843, 5008.17365134756, 5012.674176178537, 5016.423111342169, 4531.796069176895, 4611.0, 4617.468991066004, 4671.065786842645, 4702.435707715096, 6373.490120790326, 6378.394052564999, 6432.324605916405, 6448.613083215022, 6456.0, 6771.830704232433, 6851.520393572402, 6926.896096558556, 6956.582605043714, 6977.89533157003, 6285.308616052231, 6414.166158399378, 6426.1003459515705, 6436.678166091677, 6453.935460645427, 5577.776888924398, 5584.134459158756, 5638.069718496484, 5661.2923384576925, 5676.460736230051, 7030.578165309996, 7208.2791720828545, 7228.927710722931, 7315.963420182971, 7322.780316590511, 6826.419754320938, 6849.828754280983, 6868.828279292958, 6949.339812717783, 6952.165740111219, 7121.252268511939, 7232.42140628759, 7296.270372962661, 7313.634318283958, 7318.3047610476915, 6845.897311540431, 6862.794116176523, 6867.896981545381, 6952.096227490596, 6963.825904352431, 6811.8978215325815, 6845.760398386033, 6858.314168583302, 6865.588064716133, 6885.277045910308, 6638.037484564615, 6645.800625981228, 6692.464602831665, 6773.796786096425, 6785.660716964033, 6621.039949207434, 6664.133662623828, 6744.022116793136, 6745.392914637706, 6759.86480270382, 6582.506312026521, 6622.768203112868, 6683.13119294508, 6684.498662600422, 6716.764913228014, 6632.4694024478895, 6677.399034086956, 6694.163229596301, 6723.2940541244425, 6832.316768323128, 6453.257875344396, 6507.511936604679, 6525.184351956005, 6533.542652014314, 6551.50863685216], "value": 6284.800802673295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.3683958068937, 916.399758158406, 948.8434408322627, 984.6602921991913, 984.7636567223864, 43367.78316108419, 44050.559494405046, 44202.557974420284, 44239.33640995384, 44246.336304955454, 41148.0, 41486.17027659452, 41591.58408415915, 41615.58384416155, 41713.0, 7644.617769111536, 7735.033120859893, 7742.303192712655, 7751.806204844896, 7781.610919454005, 7595.81010474737, 7661.502002369856, 7716.266954639328, 7732.961335193344, 7740.380769538423, 8365.832683346329, 8574.228319451247, 8575.099614540477, 8582.613782379776, 8603.655853765842, 8433.873491897626, 8513.829723405528, 8522.659093636246, 8525.232729054353, 8528.275096616795, 8197.549134797584, 8432.494050356936, 8435.915640843574, 8440.535770532619, 8460.365472589581, 40079.0, 40353.596464035276, 40362.0, 40383.39424908629, 40406.59593404087, 3650.361186792301, 3696.2053158571034, 3699.7965111918834, 3710.239400922804, 3711.77729336238, 33263.33473330544, 33385.0, 33395.16512087193, 33412.6658733412, 33419.0, 5482.671039737588, 5487.725613719338, 5488.4237155098535, 5501.587380946445, 5514.558835293207, 220204.0, 220537.0, 221017.0, 221188.0, 221872.8906355474, 51949.7402512985, 52570.47429525732, 54806.45193548093, 55548.16677749837, 55755.0, 58836.411635883094, 58915.0, 59094.40905590975, 59306.0, 59327.0, 17064.2321095551, 17156.485305440856, 17187.0, 17308.307667693403, 17497.0, 14052.859471405154, 14160.716785664436, 14192.432302707983, 14194.787078193835, 14196.929015354857, 15596.376144954302, 15608.921955390377, 15658.843411565966, 15664.608384790243, 15674.012358260181, 6129.601575897553, 6228.532860035515, 6257.937420625826, 6273.905891411632, 6335.778247761306, 1102.6967583914488, 1112.5104953820294, 1119.9608013719644, 1122.2761318949233, 1122.5678113926197, 26457.31421796709, 26471.47057058848, 26618.20145395641, 26670.0, 26717.866410667822, 1197.8802119788127, 1203.12172114357, 1214.5081242096965, 1220.951161953512, 1234.0312854409246, 13888.722225555432, 13933.0, 14121.364538595788, 14255.0, 14301.0, 283677.0, 283755.0, 283797.0, 286078.0, 286699.0, 58219.0, 61139.38860611426, 61659.383406166264, 62118.68940655268, 62132.0, 1514.4320879670124, 1537.3389442539815, 1556.2374436526247, 1567.1145802621481, 1568.8509591588781, 30869.382612348076, 30928.0, 31146.53280200844, 31227.063188104392, 31843.681563184073, 42902.14195716131, 43214.78392608017, 43322.566774331855, 43353.0, 43365.566344336155, 254263.0, 254328.0, 254731.0, 254796.0, 255365.0, 36697.44953825748, 36952.0, 37572.62427375691, 37588.0, 38443.80778096092, 46179.30731039104, 47919.28121078117, 47998.280025798944, 48509.5149048505, 48623.27065093956, 34297.657023430445, 34462.310753785285, 34677.65322346845, 34748.82625586856, 34762.13094672552, 34341.828290858386, 34590.481142783385, 34679.13302167466, 34990.47514287339, 35126.473102902964, 39038.804805975786, 40241.0, 40374.0, 40423.59576404316, 40667.59332406638, 33360.66639333672, 33469.66530334763, 33528.832355838065, 33774.831125845194, 34139.97580072602, 24857.87571062133, 25993.0, 26354.86822565875, 26466.941322347662, 26646.46707065809], "value": 18975.926351156515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4146531527708, 624.4848000399671, 627.5356236385073, 635.114015947753, 646.5183438338437, 23179.420514487127, 23817.76182238177, 23999.64000539991, 24016.639750403716, 24042.39894002651, 25067.62398564023, 26457.20628381147, 26496.86751566244, 26508.734912650867, 26532.33669158272, 5995.640261584297, 6008.489278411318, 6011.519078473733, 6035.215421995134, 6035.245594300713, 6698.698558564852, 6946.444284457231, 6962.094927659397, 6974.0, 6993.545419547739, 6944.756933507303, 6978.9302106978785, 6979.685914133876, 6980.9301906981045, 6982.441404687638, 6651.301613330603, 6899.827504312382, 6913.170419549636, 6918.238993710688, 6919.4464442844455, 6375.2668443128705, 6388.7125079371535, 6455.257645370795, 6460.870782584322, 6473.320301368382, 30690.846545767352, 31066.689333106606, 31114.53328200079, 31268.37463250745, 31312.21719457009, 2115.132795553831, 2164.7835216478384, 2197.6703494475796, 2197.6923230747707, 2199.4611320226645, 20076.49808754778, 20829.270975515785, 20834.791652083437, 20850.374488765363, 20930.476738081517, 2539.7968162546954, 2563.2950938491877, 2614.3856193794445, 2628.093307808803, 2631.0528209844633, 124201.0, 133493.0, 134460.32769836186, 148458.25770871184, 159460.0, 15357.078575285519, 16123.435679751152, 16447.91776041112, 16664.41674541385, 16731.6653666926, 26033.73966260351, 26230.34424139412, 26265.73734262633, 26298.737012630012, 26368.20895373142, 10262.43556604379, 10299.0, 10473.423961682029, 10514.789704206027, 10524.52639631203, 9238.907610923805, 9242.146022114945, 9323.953380233192, 9336.57985390659, 9362.531873406302, 9795.657151999645, 9833.213342932548, 9892.703218903445, 10099.343542669703, 10208.336458130347, 2784.832910025405, 2805.088346287465, 2820.576913462997, 2828.0, 2877.9424411511654, 987.2151639446657, 993.3195760903805, 1004.347174336687, 1009.5204777730667, 1017.4302390661253, 20339.0, 20545.794542054387, 20714.17143314281, 20901.581968360548, 20990.68513972261, 1054.9894501054891, 1063.250408462048, 1064.1008347945974, 1068.7488440216698, 1074.7366895110747, 11389.65831025054, 11615.303081815118, 11655.417229138679, 11757.823632645517, 11793.233439826556, 534073.0, 550215.0, 552445.0, 558611.0, 559775.0, 128745.0, 128787.0, 130008.0, 132135.33932330276, 133198.0, 1234.8456442944632, 1246.0779023522527, 1275.5599318235195, 1324.503311258259, 1334.0261609025272, 22792.0, 22831.543369132192, 23170.536589268457, 23262.3021309361, 23386.64920026167, 62038.37961620326, 63362.683186583774, 65016.0, 65743.0, 66333.0, 77510.2248977503, 77780.61109694415, 77980.61009694915, 78076.0, 78387.60806195933, 15786.68426631484, 16199.352025918832, 16282.185890705654, 16283.59291017734, 16292.0, 24005.0, 24278.27165185047, 24297.878510607334, 24551.75448245566, 24633.753662463147, 20228.494287642927, 20273.695894561297, 20274.189032439128, 20320.695189571874, 20546.178152874316, 17293.308267669654, 17359.91320043442, 17465.738013930055, 17972.460826175236, 17994.0, 18619.906900465412, 18663.44009679712, 20568.0, 20852.895735521226, 20867.06098225553, 15790.0, 15863.52409427719, 15907.0, 16008.35966561371, 16026.839731603, 19225.13486893121, 19389.903050484656, 19514.707279391103, 19604.411867643994, 19628.116734747255], "value": 12797.607968950635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.4810668159464, 1540.8690261327786, 1554.2151213637112, 1556.595285225841, 1560.9141497217656, 17650.11749412529, 18065.0, 18103.909480452614, 18123.637527249448, 18128.728069078974, 17675.82324176761, 17682.911585442056, 17690.911545442254, 17693.734593981102, 17777.0, 2870.225039239404, 2921.24047747585, 2925.970740292602, 2927.0633397312868, 2934.750546203575, 2782.3044238940265, 2828.7595554377904, 2831.7593004594632, 2856.0289501569464, 2857.1571386440946, 2749.2439579115703, 2829.688734239232, 2829.915102546927, 2835.206142280165, 2835.234486688593, 2679.8124131310815, 2737.438825040862, 2759.503289407916, 2759.889604415821, 2761.226856480179, 2664.280644226048, 2707.945841083167, 2709.4851978124093, 2710.0514819813106, 2710.688270848858, 16340.428085017085, 16692.83307166925, 16693.332266709316, 16713.49859504217, 16722.58193545171, 8520.957395212985, 8744.431611945203, 8839.823203535892, 8893.510856902867, 8899.822003559893, 5267.789288428458, 5524.613277070606, 5553.0, 5584.6090773645865, 5735.770569177228, 2073.170731707314, 2134.7224860768, 2167.4039639099374, 2180.8364372672113, 2198.2525941179915, 30916.53625195624, 31006.224844378845, 31093.689063109305, 31103.066907992797, 31130.688693113007, 6871.278515755874, 7144.3212894774915, 7814.4529882907655, 7969.8406031880195, 8041.075276343178, 23173.652395214085, 23251.18620848296, 23417.648735268984, 23438.765612344, 23572.29283121509, 8865.335099867536, 8935.419197752126, 8955.41789783662, 9001.684941027033, 9004.954975225082, 7838.960805196051, 8067.475614085066, 8107.351411887035, 8117.918820811835, 8129.268365847102, 6193.535484838655, 6242.15730876335, 6246.875062498724, 6290.433860952445, 6343.1436756038265, 1897.345415831536, 1932.2753967262277, 1961.4115765270362, 1964.0670681426209, 1971.0735954101835, 919.7516670498928, 944.0417975754615, 946.6450081219542, 947.5072962059828, 948.5968463403026, 9363.765905852408, 9482.478463684425, 9691.9030809691, 9721.902780972241, 9764.121229089416, 786.5320134519951, 794.5312265763112, 800.1438460846838, 800.4876878797575, 811.853866304071, 5422.457754224546, 5452.182172674131, 5502.532284755761, 5507.4767897050515, 5528.806491772769, 24392.146274880295, 24778.752212478004, 25393.11124110647, 25413.364665883502, 25428.237152885442, 25015.499690006098, 25196.874015629804, 25198.24405267845, 25199.62200566993, 25278.36804079876, 11240.606578769704, 12192.329421881881, 12197.451114699683, 12376.876231237753, 12406.193597416139, 10021.148202402877, 10039.799204015733, 10056.195504359488, 10074.244431667508, 10075.496225188564, 20905.89547052316, 21390.893045534674, 21457.03443345022, 21790.128394864027, 21819.0, 22018.33944981589, 22086.558268834855, 22149.003294852093, 22435.551288974457, 22473.43816404603, 13827.516036939061, 14053.086549374259, 14061.859381406464, 14062.648433789238, 14073.0, 15909.761353579937, 15936.36254549805, 16057.678846422772, 16208.10855402917, 16220.51338459848, 12673.8098928518, 12690.302033388252, 12701.047421443243, 13028.739425211632, 13095.541656041993, 12228.327441990776, 12335.321557314433, 12389.690257743629, 12408.937955310166, 12689.873101269239, 10652.786944260917, 10711.0, 10793.784124317626, 10903.073238774792, 10910.509027093958, 8729.170728780755, 8734.0, 8787.736367908972, 8853.822923541622, 8883.600237989176, 8538.530380829114, 8619.353548483763, 8647.178518040777, 8701.303895688456, 8780.868286975829], "value": 7489.337100165155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.1639210048124, 551.2337850387961, 561.2619405481794, 568.0910543130993, 585.5257241634276, 6147.846303842406, 6245.531585131122, 6250.9062364064575, 6278.434940855322, 6285.5914365566205, 6239.937600624004, 6257.124002639634, 6275.6548389838545, 6301.621902685831, 6315.873682526347, 4891.4130304363525, 5017.67385119966, 5038.748062596856, 5172.431032586413, 5236.528712415882, 5065.721385323805, 5095.847124586268, 5116.0, 5117.309163262949, 5122.692638441706, 5039.496050394968, 5045.369328833895, 5052.646314757969, 5071.3407257056715, 5076.670016448919, 4995.450500444948, 5053.6860416291665, 5054.216596427523, 5066.949330506703, 5098.209777484459, 4579.152856721517, 4628.606568441686, 4630.351750754863, 4635.351050852883, 4651.488336283006, 6094.360092190301, 6113.449789518964, 6115.724792384353, 6131.14164017038, 6206.689665516707, 5777.422257774231, 5816.975172910105, 5856.238688970449, 5871.823845284648, 5876.177335173079, 6623.437007854338, 6634.9715794052, 6642.269350371455, 6667.233268174125, 6723.495737819683, 5086.415062267813, 5093.006863661588, 5095.108356037678, 5124.76938537763, 5143.562797162245, 6886.793396198122, 6985.685644146026, 7057.2356910772305, 7069.399101076363, 7074.7877563672655, 5268.78924843002, 5275.261463395128, 5275.5515781158265, 5280.683159010472, 5292.603054770831, 5303.734813259399, 5321.414644389114, 5352.946470535323, 5373.543248823816, 5440.129579267298, 5854.970725146347, 5863.20846685692, 5889.793857214977, 5898.351181370046, 5910.586258961917, 6283.340249273851, 6322.873542529215, 6518.57629254097, 6560.934390656128, 6588.374104460068, 1805.9187336569885, 1827.570520927581, 1830.3593742190126, 1837.7059670452663, 1848.4731851422548, 1226.405193481161, 1294.6310301564008, 1315.224017829485, 1317.3610798762593, 1330.6074707961175, 5983.700814959235, 6170.382961703794, 6173.660448675366, 6176.227971503562, 6192.195014648067, 6658.966705166443, 6677.699503522354, 6682.331766823376, 6703.262641109474, 6711.832204194934, 6145.723442445012, 6190.628562286187, 6192.349803270682, 6210.968945155336, 6219.782307619212, 3498.5626796650417, 3550.715942724576, 3557.1462848916076, 3557.626449222846, 3567.304375646776, 6934.271901450376, 7022.578645281299, 7025.367716905503, 7046.964765176142, 7075.363217310467, 6858.417034552119, 6872.896906546406, 6924.88380228899, 6986.755463558751, 7005.614691191931, 7070.116235470567, 7093.680784364716, 7100.609466479394, 7121.35907768293, 7123.786286411416, 6629.370209830058, 6683.331666833278, 6698.363655452919, 6762.966185169043, 6789.0, 6700.229473610597, 6710.328967103446, 6715.496337774589, 6751.898721519279, 6796.320367963164, 7046.907729301966, 7081.610511421921, 7132.251113633201, 7139.928600713926, 7150.427965762622, 5201.583873290052, 5240.423553409199, 5244.160934250502, 5264.73676316175, 5286.418493965583, 6754.86490270182, 6788.898166527605, 6821.522493425413, 6836.829079273058, 6882.69027893736, 6604.867902642017, 6612.867742645217, 6634.635095069818, 6664.900026499509, 6678.599284042973, 6421.068945003042, 6520.739170433129, 6538.215414150142, 6546.312637173029, 6584.144061272004, 6426.485881129592, 6454.838629034311, 6513.4463570595135, 6517.3808488193545, 6528.445082168069, 6110.205673262448, 6502.139058814107, 6594.208694956636, 6609.966950165219, 6627.768028118992, 6310.0, 6350.174477317919, 6391.0, 6394.488440924808, 6426.871462570629], "value": 5202.734855031132, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.5019839881662, 991.1971303244372, 1005.2711783956632, 1015.1168483419426, 1020.2705065877898, 19109.808901910976, 19161.61676766464, 19167.616647667037, 19322.71015934762, 19348.70976935347, 17383.304667813303, 17501.649967000652, 17551.82448175518, 19151.521211969706, 19642.410727678158, 1036.1037702387418, 1055.9260851740382, 1056.2922841696081, 1057.788442311537, 1061.029158320136, 1070.4433694478867, 1070.550368845083, 1071.0200166847326, 1071.1377341240297, 1072.0458791675414, 1119.7368618374676, 1155.8901904319075, 1159.1016961854546, 1159.4782347943417, 1159.907207423404, 1154.0306142840054, 1154.2266681323492, 1154.4747140051256, 1159.0, 1163.4764356039816, 780.3211206250542, 801.9759407217792, 808.127222599591, 823.9134890836435, 829.0755807274905, 20810.0, 20939.68590471144, 21014.474638134016, 21063.262785802424, 21091.15635374583, 22197.667034994487, 22519.549609007892, 22961.54076918452, 23028.078876844906, 23050.53898922029, 17881.821181788146, 17882.642347152985, 17997.820021799744, 18014.189361478766, 18145.81854181468, 3862.5558060822805, 3904.12157264616, 3908.2965066288057, 3920.5099362579676, 3924.1170736584327, 126685.0, 160753.19623401808, 163962.0, 164226.0, 165341.17329413275, 18457.261709531736, 18473.81526184721, 19056.809431905782, 19183.52041198953, 19196.328128515433, 34688.479672804926, 34813.30373392518, 34966.12584685352, 35034.82482587571, 35336.64663353334, 9881.407115573089, 9889.80220395588, 9963.153131983863, 9963.601455941682, 9987.051230133126, 4247.702660813775, 4347.108842687241, 4365.738055716667, 4449.421575195269, 4478.57453541913, 5919.4968427684125, 6034.064719968412, 6034.426729460694, 6056.9697151513965, 6067.7864427114755, 1242.589945318043, 1280.4238092858252, 1285.9357032148355, 1286.3503930515217, 1287.2598256002836, 736.131364989307, 751.5265382808905, 755.9584222867795, 767.2327672327673, 775.4339332287461, 12776.488940442465, 12819.16675416095, 13862.792058119136, 14462.20457874806, 14534.127952322682, 728.5847067171661, 728.6866647341589, 728.7085165933563, 739.2459691115032, 742.5767312631748, 6235.220597425322, 6299.401556852092, 6325.9051114233325, 6381.1066450696935, 6456.54804163704, 144802.0, 147899.0, 149262.1033055373, 150432.0, 152044.0, 100991.63309575504, 125650.0, 127129.0, 129744.0, 132896.0, 111116.0, 111267.0, 111498.0, 111672.0, 112086.43956780164, 14636.41454341857, 14680.265986700835, 14719.92640036793, 14797.704045919236, 14994.775078374052, 51609.74195129, 51636.0, 51760.0, 53127.468725313796, 53785.0, 68887.3111268901, 69804.65097674682, 70160.64919675369, 70177.64911175412, 70197.0, 19308.13113409872, 19720.11259493355, 19947.401577952685, 19960.90215038187, 20162.395128146178, 21310.147594096063, 21438.356849294545, 21444.0, 21627.567448650625, 21704.782952170277, 20114.09486573137, 20331.0, 20359.287424940056, 20381.79618203799, 20457.07943142592, 18975.715364269825, 19095.0, 19097.809021909605, 19163.32928347501, 19244.23023079061, 17968.19143138588, 17981.460556183334, 18116.27534898589, 18157.27370905149, 18157.54606134857, 14772.48296309624, 14942.925285373503, 14961.700765984402, 15097.698046039237, 15140.772888406904, 14316.355763990437, 14349.067310624776, 14375.568732938029, 14591.0, 14844.925775371054], "value": 10152.289819889445, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1366.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 107.0, 105.0, 105.0, 106.0, 106.0, 105.0, 104.0, 105.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 116.0, 114.0, 116.0, 113.0, 112.0, 137.0, 110.0, 112.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 161.0, 164.0, 165.0, 163.0, 162.0, 168.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 75.0, 73.0, 75.0, 73.0, 73.0, 73.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 77.0, 77.0, 77.0, 77.0, 78.0, 76.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 150.0, 151.0, 151.0, 152.0, 151.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 44.0, 44.0, 43.0, 42.0, 44.0, 42.0, 43.0, 43.0, 42.0], "value": 43.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [35.0, 35.0, 35.0, 35.0, 34.0, 36.0, 36.0, 35.0, 34.0, 35.0], "value": 35.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 72.0, 69.0, 70.0, 70.0, 72.0, 72.0, 71.0, 71.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 104.0, 109.0, 107.0, 116.0, 106.0, 108.0, 109.0, 106.0], "value": 107.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 149.0, 153.0, 153.0, 152.0, 150.0, 150.0, 154.0, 154.0, 155.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 62.0, 60.0, 59.0, 61.0, 64.0, 61.0, 65.0, 61.0], "value": 62.5, "unit": "score"}]}]} 16:47:57 INFO - Return code: 0 16:47:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:47:57 INFO - # TBPL SUCCESS # 16:47:57 INFO - Running post-action listener: _package_coverage_data 16:47:57 INFO - Running post-action listener: _resource_record_post_action 16:47:57 INFO - [mozharness: 2017-09-22 23:47:57.259631Z] Finished run-tests step (success) 16:47:57 INFO - Running post-run listener: _resource_record_post_run 16:47:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 336162816; Read time: 192; Write time: 222612 16:47:57 INFO - TinderboxPrint: CPU usage
13.1% 16:47:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 192 16:47:57 INFO - TinderboxPrint: I/O write bytes / time
336,162,816 / 222,612 16:47:57 INFO - TinderboxPrint: CPU idle
8,218.5 (86.9%) 16:47:57 INFO - TinderboxPrint: CPU user
1,187.3 (12.6%) 16:47:57 INFO - TinderboxPrint: Swap in / out
0 / 0 16:47:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13062144; Read time: 0; Write time: 1700 16:47:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:47:57 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 12288; Write bytes: 322596864; Read time: 192; Write time: 220888 16:47:57 INFO - Running post-run listener: _upload_blobber_files 16:47:57 INFO - Blob upload gear active. 16:47:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:47:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:47:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:47:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:47:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:47:59 INFO - (blobuploader) - INFO - Done attempting. 16:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:00 INFO - (blobuploader) - INFO - Done attempting. 16:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:07 INFO - (blobuploader) - INFO - Done attempting. 16:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:08 INFO - (blobuploader) - INFO - Done attempting. 16:48:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:48:08 INFO - Return code: 0 16:48:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:48:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:48:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f30ecadf51fd6f7c89980f622c855769b389ef1583fa4c05359b4142785913bd34f9863e967c5d0da80729b8316955f2504c10bce59b8abd51079b419e18f2e0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f304dbe629f24ad42943c5e66cbfc4eccfa1a2b5105930c7143fd22c64c221c79d1512cf0e8c043b1a1b7fd3249164a0652881f13879ca4e4fa3e0230492a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/296afe34a0bb01f69adbae4304e3b397c46d18008340d2465fe1bfb0cbdaac700d49e6e078350f677386a443001b2f34f89970cd88b145e95e9626172b3ab1c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a92a15ac1b8e04ee09a7bf7daa0337eb157f0ff904f64cc279703c0fd24f3e7084d8186a48eac63b582604c64bd1604fd9c6ab6ff08e6cf7043b4a31ece4015"} 16:48:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:48:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:48:08 INFO - Contents: 16:48:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f30ecadf51fd6f7c89980f622c855769b389ef1583fa4c05359b4142785913bd34f9863e967c5d0da80729b8316955f2504c10bce59b8abd51079b419e18f2e0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f304dbe629f24ad42943c5e66cbfc4eccfa1a2b5105930c7143fd22c64c221c79d1512cf0e8c043b1a1b7fd3249164a0652881f13879ca4e4fa3e0230492a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/296afe34a0bb01f69adbae4304e3b397c46d18008340d2465fe1bfb0cbdaac700d49e6e078350f677386a443001b2f34f89970cd88b145e95e9626172b3ab1c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a92a15ac1b8e04ee09a7bf7daa0337eb157f0ff904f64cc279703c0fd24f3e7084d8186a48eac63b582604c64bd1604fd9c6ab6ff08e6cf7043b4a31ece4015"} 16:48:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:48:08 INFO - Copying logs to upload dir... 16:48:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:48:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.250147 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-22 16:48:08.530826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 16:48:08.534982) ========= 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=d2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f30ecadf51fd6f7c89980f622c855769b389ef1583fa4c05359b4142785913bd34f9863e967c5d0da80729b8316955f2504c10bce59b8abd51079b419e18f2e0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f304dbe629f24ad42943c5e66cbfc4eccfa1a2b5105930c7143fd22c64c221c79d1512cf0e8c043b1a1b7fd3249164a0652881f13879ca4e4fa3e0230492a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/296afe34a0bb01f69adbae4304e3b397c46d18008340d2465fe1bfb0cbdaac700d49e6e078350f677386a443001b2f34f89970cd88b145e95e9626172b3ab1c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a92a15ac1b8e04ee09a7bf7daa0337eb157f0ff904f64cc279703c0fd24f3e7084d8186a48eac63b582604c64bd1604fd9c6ab6ff08e6cf7043b4a31ece4015"} build_url:https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/cbFdpQ8wTE6HRI4Bano6mQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f30ecadf51fd6f7c89980f622c855769b389ef1583fa4c05359b4142785913bd34f9863e967c5d0da80729b8316955f2504c10bce59b8abd51079b419e18f2e0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f304dbe629f24ad42943c5e66cbfc4eccfa1a2b5105930c7143fd22c64c221c79d1512cf0e8c043b1a1b7fd3249164a0652881f13879ca4e4fa3e0230492a1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/296afe34a0bb01f69adbae4304e3b397c46d18008340d2465fe1bfb0cbdaac700d49e6e078350f677386a443001b2f34f89970cd88b145e95e9626172b3ab1c0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a92a15ac1b8e04ee09a7bf7daa0337eb157f0ff904f64cc279703c0fd24f3e7084d8186a48eac63b582604c64bd1604fd9c6ab6ff08e6cf7043b4a31ece4015"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 16:48:08.564001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:48:08.564375) ========= 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=d2a8c569965ab8367867b893000001a1-1506121384.154013-1762369656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:48:08.647676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 16:48:08.648013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 16:48:08.648432) ========= ========= Total master_lag: 0.16 =========