builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-042 starttime: 1505858508.59 results: success (0) revision: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.593109) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.593495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.593757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.641968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.642225) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 15:01:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.6M=0s 2017-09-19 15:01:48 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104044 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.768437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.768718) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020767 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:48.822045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-19 15:01:48.822347) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f --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 c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f --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=74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 15:01:48,881 truncating revision to first 12 chars 2017-09-19 15:01:48,881 Setting DEBUG logging. 2017-09-19 15:01:48,881 attempt 1/10 2017-09-19 15:01:48,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0d1f9eb2a40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 15:01:49,851 unpacking tar archive at: mozilla-central-c0d1f9eb2a40/testing/mozharness/ program finished with exit code 0 elapsedTime=1.269064 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-19 15:01:50.110187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:50.113529) ========= script_repo_revision: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:50.113892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:50.114150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:50.127292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-19 15:01:50.127632) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:50 INFO - MultiFileLogger online at 20170919 15:01:50 in /builds/slave/test 15:01:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:01:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:50 INFO - {'append_to_log': False, 15:01:50 INFO - 'base_work_dir': '/builds/slave/test', 15:01:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:01:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:50 INFO - 'branch': 'Firefox-Non-PGO', 15:01:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:50 INFO - 'code_coverage': False, 15:01:50 INFO - 'config_files': ('talos/linux_config.py',), 15:01:50 INFO - 'default_actions': ('clobber', 15:01:50 INFO - 'read-buildbot-config', 15:01:50 INFO - 'download-and-extract', 15:01:50 INFO - 'populate-webroot', 15:01:50 INFO - 'create-virtualenv', 15:01:50 INFO - 'install', 15:01:50 INFO - 'setup-mitmproxy', 15:01:50 INFO - 'run-tests'), 15:01:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:50 INFO - 'disable_ccov_upload': False, 15:01:50 INFO - 'disable_stylo': False, 15:01:50 INFO - 'download_minidump_stackwalk': True, 15:01:50 INFO - 'download_symbols': 'ondemand', 15:01:50 INFO - 'enable_stylo': False, 15:01:50 INFO - 'enable_webrender': False, 15:01:50 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:01:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:50 INFO - 'gecko_profile': False, 15:01:50 INFO - 'gecko_profile_interval': 0, 15:01:50 INFO - 'installer_path': 'installer.exe', 15:01:50 INFO - 'log_level': 'info', 15:01:50 INFO - 'log_name': 'talos', 15:01:50 INFO - 'log_to_console': True, 15:01:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:50 INFO - 'opt_config_files': (), 15:01:50 INFO - 'pip_index': False, 15:01:50 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:01:50 INFO - 'system_bits': '32', 15:01:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:50 INFO - 'title': 'talos-linux64-ix-042', 15:01:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:50 INFO - 'use_talos_json': True, 15:01:50 INFO - 'verify': 'False', 15:01:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:50 INFO - 'work_dir': 'build'} 15:01:50 INFO - [mozharness: 2017-09-19 22:01:50.320792Z] Running clobber step. 15:01:50 INFO - Running pre-action listener: _resource_record_pre_action 15:01:50 INFO - Running main action method: clobber 15:01:50 INFO - rmtree: /builds/slave/test/build 15:01:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:51 INFO - Running post-action listener: _resource_record_post_action 15:01:51 INFO - [mozharness: 2017-09-19 22:01:51.318607Z] Finished clobber step (success) 15:01:51 INFO - [mozharness: 2017-09-19 22:01:51.318707Z] Running read-buildbot-config step. 15:01:51 INFO - Running pre-action listener: _resource_record_pre_action 15:01:51 INFO - Running main action method: read_buildbot_config 15:01:51 INFO - Using buildbot properties: 15:01:51 INFO - { 15:01:51 INFO - "project": "", 15:01:51 INFO - "product": "firefox", 15:01:51 INFO - "who": "kwierso@gmail.com", 15:01:51 INFO - "installer_path": "public/build/target.tar.bz2", 15:01:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:01:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:01:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:01:51 INFO - "stage_platform": "linux64", 15:01:51 INFO - "basedir": "/builds/slave/test", 15:01:51 INFO - "buildnumber": 44, 15:01:51 INFO - "platform": "ubuntu64_hw", 15:01:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:01:51 INFO - "slavebuilddir": "test", 15:01:51 INFO - "taskId": "YgkJeKiVR56h3g1sOszxFQ", 15:01:51 INFO - "branch": "mozilla-central", 15:01:51 INFO - "script_repo_revision": "production", 15:01:51 INFO - "revision": "c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f", 15:01:51 INFO - "slavename": "talos-linux64-ix-042", 15:01:51 INFO - "repo_path": "mozilla-central" 15:01:51 INFO - } 15:01:51 INFO - Finding installer, test and symbols from parent task. 15:01:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgkJeKiVR56h3g1sOszxFQ'}, attempt #1 15:01:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgkJeKiVR56h3g1sOszxFQ'}, attempt #1 15:01:52 INFO - Task dependencies: AyerD6BRQGKrCIFu0VWbgg 15:01:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg'}, attempt #1 15:01:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:01:52 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.test_packages.json 15:01:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip 15:01:52 INFO - Running post-action listener: _resource_record_post_action 15:01:52 INFO - [mozharness: 2017-09-19 22:01:52.867732Z] Finished read-buildbot-config step (success) 15:01:52 INFO - [mozharness: 2017-09-19 22:01:52.867950Z] Running download-and-extract step. 15:01:52 INFO - Running pre-action listener: _resource_record_pre_action 15:01:52 INFO - Running main action method: download_and_extract 15:01:52 INFO - mkdir: /builds/slave/test/build/tests 15:01: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')]} 15:01:52 INFO - trying https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.test_packages.json 15:01:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:01:53 INFO - Downloaded 989 bytes. 15:01:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:01:53 INFO - Using the following test package requirements: 15:01:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:01:53 INFO - u'common': [u'target.common.tests.zip'], 15:01:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:01:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:01:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:01:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:01:53 INFO - u'mozbase': [u'target.common.tests.zip'], 15:01:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:01:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:01:53 INFO - u'web-platform': [u'target.common.tests.zip', 15:01:53 INFO - u'target.web-platform.tests.tar.gz'], 15:01:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:01:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:01:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.common.tests.zip 15:01:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:01:53 INFO - Fetch https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.common.tests.zip into memory 15:01:54 INFO - Content-Length response header: 54731597 15:01:54 INFO - Bytes received: 54731597 15:02:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.talos.tests.zip 15:02:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:02:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.talos.tests.zip into memory 15:02:06 INFO - Content-Length response header: 14508904 15:02:06 INFO - Bytes received: 14508904 15:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:06 INFO - trying https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:02:06 INFO - Downloading https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:02:07 INFO - Downloaded 61759510 bytes. 15:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:02:07 INFO - mkdir: /builds/slave/test/properties 15:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:07 INFO - Contents: 15:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:02:07 INFO - Running post-action listener: _resource_record_post_action 15:02:07 INFO - Running post-action listener: find_tests_for_verification 15:02:07 INFO - Running post-action listener: set_extra_try_arguments 15:02:07 INFO - [mozharness: 2017-09-19 22:02:07.878662Z] Finished download-and-extract step (success) 15:02:07 INFO - [mozharness: 2017-09-19 22:02:07.878757Z] Running populate-webroot step. 15:02:07 INFO - Running pre-action listener: _resource_record_pre_action 15:02:07 INFO - Running main action method: populate_webroot 15:02:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:02:07 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['tresize', 15:02:07 INFO - 'tcanvasmark']}, 15:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:02:07 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['dromaeo_css', 15:02:07 INFO - 'kraken']}, 15:02:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:07 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'tests': ['damp', 'tps']}, 15:02:07 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['damp', 'tps']}, 15:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:07 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['dromaeo_dom']}, 15:02:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:02:07 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['basic_compositor_video', 15:02:07 INFO - 'glvideo']}, 15:02:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:02:07 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['ts_paint_webext', 15:02:07 INFO - 'tp5o_webext']}, 15:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_many_windows', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['a11yr', 15:02:07 INFO - 'ts_paint', 15:02:07 INFO - 'tpaint', 15:02:07 INFO - 'sessionrestore', 15:02:07 INFO - 'sessionrestore_many_windows', 15:02:07 INFO - 'sessionrestore_no_auto_restore', 15:02:07 INFO - 'tabpaint']}, 15:02:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:02:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:02:07 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['perf_reftest_singletons']}, 15:02:07 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['bloom_basic']}, 15:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:02:07 INFO - 'tsvgr_opacity', 15:02:07 INFO - 'tart', 15:02:07 INFO - 'tscrollx', 15:02:07 INFO - 'tsvg_static']}, 15:02:07 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['tsvgx', 15:02:07 INFO - 'tsvgr_opacity', 15:02:07 INFO - 'tart', 15:02:07 INFO - 'tscrollx', 15:02:07 INFO - 'tsvg_static']}, 15:02:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:02:07 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-stylo'], 15:02:07 INFO - 'tests': ['tp5o']}, 15:02:07 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:02:07 INFO - 'talos_options': ['--mitmproxy', 15:02:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:02:07 INFO - '--firstNonBlankPaint'], 15:02:07 INFO - 'tests': ['tp6_google', 15:02:07 INFO - 'tp6_youtube', 15:02:07 INFO - 'tp6_amazon', 15:02:07 INFO - 'tp6_facebook']}, 15:02:07 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:02:07 INFO - 'talos_options': ['--disable-stylo', 15:02:07 INFO - '--mitmproxy', 15:02:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:02:07 INFO - '--firstNonBlankPaint'], 15:02:07 INFO - 'tests': ['tp6_google', 15:02:07 INFO - 'tp6_youtube', 15:02:07 INFO - 'tp6_amazon', 15:02:07 INFO - 'tp6_facebook']}, 15:02:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:02:07 INFO - 'talos_options': ['--stylo-threads=1', 15:02:07 INFO - '--mitmproxy', 15:02:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:02:07 INFO - '--firstNonBlankPaint'], 15:02:07 INFO - 'tests': ['tp6_google', 15:02:07 INFO - 'tp6_youtube', 15:02:07 INFO - 'tp6_amazon', 15:02:07 INFO - 'tp6_facebook']}, 15:02:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'talos_options': ['--xperf_path', 15:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:07 INFO - 'tests': ['tp5n']}, 15:02:07 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:02:07 INFO - 'talos_options': ['--disable-stylo', 15:02:07 INFO - '--xperf_path', 15:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:07 INFO - 'tests': ['tp5n']}}} 15:02:07 INFO - Running post-action listener: _resource_record_post_action 15:02:07 INFO - [mozharness: 2017-09-19 22:02:07.893679Z] Finished populate-webroot step (success) 15:02:07 INFO - [mozharness: 2017-09-19 22:02:07.893768Z] Running create-virtualenv step. 15:02:07 INFO - Running pre-action listener: _resource_record_pre_action 15:02:07 INFO - Running main action method: create_virtualenv 15:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:07 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:02:07 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:02:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:08 INFO - Installing pip...............done. 15:02:08 INFO - Return code: 0 15:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:02:09 INFO - Reading from file tmpfile_stdout 15:02:09 INFO - Output received: 15:02:09 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:02:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:09 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 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:02:09 INFO - Using env: {'DISPLAY': ':0', 15:02:09 INFO - 'HOME': '/home/cltbld', 15:02:09 INFO - 'LANG': 'en_US.UTF-8', 15:02:09 INFO - 'LANGUAGE': 'en_US:en', 15:02:09 INFO - 'LOGNAME': 'cltbld', 15:02:09 INFO - 'MAIL': '/var/mail/cltbld', 15:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:09 INFO - 'MOZ_NO_REMOTE': '1', 15:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:09 INFO - 'NO_EM_RESTART': '1', 15:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:09 INFO - 'PWD': '/builds/slave/test', 15:02:09 INFO - 'SHELL': '/bin/bash', 15:02:09 INFO - 'SHLVL': '1', 15:02:09 INFO - 'TERM': 'linux', 15:02:09 INFO - 'TMOUT': '86400', 15:02:09 INFO - 'USER': 'cltbld', 15:02:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:09 INFO - '_': '/tools/buildbot/bin/python'} 15:02:10 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:02:10 INFO - Downloading/unpacking pip>=1.5 15:02:10 INFO - Running setup.py egg_info for package pip 15:02:10 INFO - warning: no files found matching 'pip/cacert.pem' 15:02:10 INFO - warning: no files found matching '*.html' under directory 'docs' 15:02:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:02:10 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:02:10 INFO - Installing collected packages: pip 15:02:10 INFO - Found existing installation: pip 1.1 15:02:10 INFO - Uninstalling pip: 15:02:10 INFO - Successfully uninstalled pip 15:02:10 INFO - Running setup.py install for pip 15:02:10 INFO - warning: no files found matching 'pip/cacert.pem' 15:02:10 INFO - warning: no files found matching '*.html' under directory 'docs' 15:02:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:02:10 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:02:10 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:02:10 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:02:10 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:02:10 INFO - Successfully installed pip 15:02:10 INFO - Cleaning up... 15:02:10 INFO - Return code: 0 15:02:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02: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', '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 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:02: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 psutil>=3.1.1 15:02:10 INFO - Using env: {'DISPLAY': ':0', 15:02:10 INFO - 'HOME': '/home/cltbld', 15:02:10 INFO - 'LANG': 'en_US.UTF-8', 15:02:10 INFO - 'LANGUAGE': 'en_US:en', 15:02:10 INFO - 'LOGNAME': 'cltbld', 15:02:10 INFO - 'MAIL': '/var/mail/cltbld', 15:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:10 INFO - 'MOZ_NO_REMOTE': '1', 15:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:10 INFO - 'NO_EM_RESTART': '1', 15:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:10 INFO - 'PWD': '/builds/slave/test', 15:02:10 INFO - 'SHELL': '/bin/bash', 15:02:10 INFO - 'SHLVL': '1', 15:02:10 INFO - 'TERM': 'linux', 15:02:10 INFO - 'TMOUT': '86400', 15:02:10 INFO - 'USER': 'cltbld', 15:02:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:10 INFO - '_': '/tools/buildbot/bin/python'} 15:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:10 INFO - Downloading/unpacking psutil>=3.1.1 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:11 INFO - Installing collected packages: psutil 15:02:11 INFO - Running setup.py install for psutil 15:02:11 INFO - building 'psutil._psutil_linux' extension 15:02:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:02:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:02:12 INFO - building 'psutil._psutil_posix' extension 15:02:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:02:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:12 INFO - Successfully installed psutil 15:02:12 INFO - Cleaning up... 15:02:12 INFO - Return code: 0 15:02:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:02:12 INFO - Using env: {'DISPLAY': ':0', 15:02:12 INFO - 'HOME': '/home/cltbld', 15:02:12 INFO - 'LANG': 'en_US.UTF-8', 15:02:12 INFO - 'LANGUAGE': 'en_US:en', 15:02:12 INFO - 'LOGNAME': 'cltbld', 15:02:12 INFO - 'MAIL': '/var/mail/cltbld', 15:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:12 INFO - 'MOZ_NO_REMOTE': '1', 15:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:12 INFO - 'NO_EM_RESTART': '1', 15:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:12 INFO - 'PWD': '/builds/slave/test', 15:02:12 INFO - 'SHELL': '/bin/bash', 15:02:12 INFO - 'SHLVL': '1', 15:02:12 INFO - 'TERM': 'linux', 15:02:12 INFO - 'TMOUT': '86400', 15:02:12 INFO - 'USER': 'cltbld', 15:02:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:12 INFO - '_': '/tools/buildbot/bin/python'} 15:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:02:13 INFO - Installing collected packages: mozsystemmonitor 15:02:13 INFO - Running setup.py install for mozsystemmonitor 15:02:13 INFO - Successfully installed mozsystemmonitor 15:02:13 INFO - Cleaning up... 15:02:16 INFO - Return code: 0 15:02:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:02:16 INFO - Using env: {'DISPLAY': ':0', 15:02:16 INFO - 'HOME': '/home/cltbld', 15:02:16 INFO - 'LANG': 'en_US.UTF-8', 15:02:16 INFO - 'LANGUAGE': 'en_US:en', 15:02:16 INFO - 'LOGNAME': 'cltbld', 15:02:16 INFO - 'MAIL': '/var/mail/cltbld', 15:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:16 INFO - 'MOZ_NO_REMOTE': '1', 15:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:16 INFO - 'NO_EM_RESTART': '1', 15:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:16 INFO - 'PWD': '/builds/slave/test', 15:02:16 INFO - 'SHELL': '/bin/bash', 15:02:16 INFO - 'SHLVL': '1', 15:02:16 INFO - 'TERM': 'linux', 15:02:16 INFO - 'TMOUT': '86400', 15:02:16 INFO - 'USER': 'cltbld', 15:02:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:16 INFO - '_': '/tools/buildbot/bin/python'} 15:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:16 INFO - Downloading/unpacking jsonschema==2.5.1 15:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:17 INFO - warning: no files found matching '*.txt' 15:02:17 INFO - no previously-included directories found matching 'build' 15:02:17 INFO - no previously-included directories found matching 'dist' 15:02:17 INFO - no previously-included directories found matching '.git*' 15:02:17 INFO - Installing collected packages: jsonschema, functools32 15:02:18 INFO - Running setup.py install for functools32 15:02:18 INFO - warning: no files found matching '*.txt' 15:02:18 INFO - no previously-included directories found matching 'build' 15:02:18 INFO - no previously-included directories found matching 'dist' 15:02:18 INFO - no previously-included directories found matching '.git*' 15:02:18 INFO - Successfully installed jsonschema functools32 15:02:18 INFO - Cleaning up... 15:02:18 INFO - Return code: 0 15:02:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:02:18 INFO - Using env: {'DISPLAY': ':0', 15:02:18 INFO - 'HOME': '/home/cltbld', 15:02:18 INFO - 'LANG': 'en_US.UTF-8', 15:02:18 INFO - 'LANGUAGE': 'en_US:en', 15:02:18 INFO - 'LOGNAME': 'cltbld', 15:02:18 INFO - 'MAIL': '/var/mail/cltbld', 15:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:18 INFO - 'MOZ_NO_REMOTE': '1', 15:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:18 INFO - 'NO_EM_RESTART': '1', 15:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:18 INFO - 'PWD': '/builds/slave/test', 15:02:18 INFO - 'SHELL': '/bin/bash', 15:02:18 INFO - 'SHLVL': '1', 15:02:18 INFO - 'TERM': 'linux', 15:02:18 INFO - 'TMOUT': '86400', 15:02:18 INFO - 'USER': 'cltbld', 15:02:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:18 INFO - '_': '/tools/buildbot/bin/python'} 15:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:02:19 INFO - Cleaning up... 15:02:19 INFO - Return code: 0 15:02:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:02:19 INFO - Using env: {'DISPLAY': ':0', 15:02:19 INFO - 'HOME': '/home/cltbld', 15:02:19 INFO - 'LANG': 'en_US.UTF-8', 15:02:19 INFO - 'LANGUAGE': 'en_US:en', 15:02:19 INFO - 'LOGNAME': 'cltbld', 15:02:19 INFO - 'MAIL': '/var/mail/cltbld', 15:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:19 INFO - 'MOZ_NO_REMOTE': '1', 15:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:19 INFO - 'NO_EM_RESTART': '1', 15:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:19 INFO - 'PWD': '/builds/slave/test', 15:02:19 INFO - 'SHELL': '/bin/bash', 15:02:19 INFO - 'SHLVL': '1', 15:02:19 INFO - 'TERM': 'linux', 15:02:19 INFO - 'TMOUT': '86400', 15:02:19 INFO - 'USER': 'cltbld', 15:02:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:19 INFO - '_': '/tools/buildbot/bin/python'} 15:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:19 INFO - Downloading/unpacking blobuploader==1.2.4 15:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:20 INFO - Downloading docopt-0.6.1.tar.gz 15:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:20 INFO - Running setup.py install for blobuploader 15:02:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:21 INFO - Running setup.py install for requests 15:02:21 INFO - Running setup.py install for docopt 15:02:21 INFO - Successfully installed blobuploader requests docopt 15:02:21 INFO - Cleaning up... 15:02:21 INFO - Return code: 0 15:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:02:21 INFO - Using env: {'DISPLAY': ':0', 15:02:21 INFO - 'HOME': '/home/cltbld', 15:02:21 INFO - 'LANG': 'en_US.UTF-8', 15:02:21 INFO - 'LANGUAGE': 'en_US:en', 15:02:21 INFO - 'LOGNAME': 'cltbld', 15:02:21 INFO - 'MAIL': '/var/mail/cltbld', 15:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:21 INFO - 'MOZ_NO_REMOTE': '1', 15:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:21 INFO - 'NO_EM_RESTART': '1', 15:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:21 INFO - 'PWD': '/builds/slave/test', 15:02:21 INFO - 'SHELL': '/bin/bash', 15:02:21 INFO - 'SHLVL': '1', 15:02:21 INFO - 'TERM': 'linux', 15:02:21 INFO - 'TMOUT': '86400', 15:02:21 INFO - 'USER': 'cltbld', 15:02:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:21 INFO - '_': '/tools/buildbot/bin/python'} 15:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:21 INFO - Running setup.py (path:/tmp/pip-dKf7SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:21 INFO - Running setup.py (path:/tmp/pip-N7XOeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:21 INFO - Running setup.py (path:/tmp/pip-zL34Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:22 INFO - Running setup.py (path:/tmp/pip-US2CPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:22 INFO - Running setup.py (path:/tmp/pip-VrLHKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:22 INFO - Running setup.py (path:/tmp/pip-WCZUXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:22 INFO - Running setup.py (path:/tmp/pip-KccRo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:22 INFO - Running setup.py (path:/tmp/pip-1zl30H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:22 INFO - Running setup.py (path:/tmp/pip-dkgFXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:22 INFO - Running setup.py (path:/tmp/pip-5_noCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:22 INFO - Running setup.py (path:/tmp/pip-Dr5xrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:22 INFO - Running setup.py (path:/tmp/pip-PtTO1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:22 INFO - Running setup.py (path:/tmp/pip-x66GIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:22 INFO - Running setup.py (path:/tmp/pip-zrJjka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:22 INFO - Running setup.py (path:/tmp/pip-SUP_En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:22 INFO - Running setup.py (path:/tmp/pip-SfQM7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:22 INFO - Running setup.py (path:/tmp/pip-nARnzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:23 INFO - Running setup.py install for manifestparser 15:02:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Running setup.py install for mozcrash 15:02:23 INFO - Running setup.py install for mozdebug 15:02:23 INFO - Running setup.py install for mozdevice 15:02:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Running setup.py install for mozfile 15:02:23 INFO - Running setup.py install for mozhttpd 15:02:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Running setup.py install for mozinfo 15:02:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Running setup.py install for mozInstall 15:02:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:23 INFO - Running setup.py install for mozleak 15:02:23 INFO - Running setup.py install for mozlog 15:02:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Running setup.py install for moznetwork 15:02:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Running setup.py install for mozprocess 15:02:24 INFO - Running setup.py install for mozprofile 15:02:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Running setup.py install for mozrunner 15:02:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Running setup.py install for mozscreenshot 15:02:24 INFO - Running setup.py install for moztest 15:02:24 INFO - Running setup.py install for mozversion 15:02:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:24 INFO - Cleaning up... 15:02:24 INFO - Return code: 0 15:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:02:24 INFO - Using env: {'DISPLAY': ':0', 15:02:24 INFO - 'HOME': '/home/cltbld', 15:02:24 INFO - 'LANG': 'en_US.UTF-8', 15:02:24 INFO - 'LANGUAGE': 'en_US:en', 15:02:24 INFO - 'LOGNAME': 'cltbld', 15:02:24 INFO - 'MAIL': '/var/mail/cltbld', 15:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:24 INFO - 'MOZ_NO_REMOTE': '1', 15:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:24 INFO - 'NO_EM_RESTART': '1', 15:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:24 INFO - 'PWD': '/builds/slave/test', 15:02:24 INFO - 'SHELL': '/bin/bash', 15:02:24 INFO - 'SHLVL': '1', 15:02:24 INFO - 'TERM': 'linux', 15:02:24 INFO - 'TMOUT': '86400', 15:02:24 INFO - 'USER': 'cltbld', 15:02:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:24 INFO - '_': '/tools/buildbot/bin/python'} 15:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:25 INFO - Running setup.py (path:/tmp/pip-ybfA3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:25 INFO - Running setup.py (path:/tmp/pip-QO1VvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:25 INFO - Running setup.py (path:/tmp/pip-BWTknT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:25 INFO - Running setup.py (path:/tmp/pip-EvCI86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:25 INFO - Running setup.py (path:/tmp/pip-XwBVfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:25 INFO - Running setup.py (path:/tmp/pip-IOCoFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:25 INFO - Running setup.py (path:/tmp/pip-tEZy9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:25 INFO - Running setup.py (path:/tmp/pip-2qPuxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:25 INFO - Running setup.py (path:/tmp/pip-o86ZRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:25 INFO - Running setup.py (path:/tmp/pip-CimngU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:25 INFO - Running setup.py (path:/tmp/pip-zXr0OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:25 INFO - Running setup.py (path:/tmp/pip-1byXM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:25 INFO - Running setup.py (path:/tmp/pip-xDeMlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:25 INFO - Running setup.py (path:/tmp/pip-DYeHV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:26 INFO - Running setup.py (path:/tmp/pip-4gjIgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:26 INFO - Running setup.py (path:/tmp/pip-9CMNJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:26 INFO - Running setup.py (path:/tmp/pip-XVhxhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:02:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:27 INFO - Downloading blessings-1.6.tar.gz 15:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:27 INFO - Installing collected packages: blessings 15:02:27 INFO - Running setup.py install for blessings 15:02:27 INFO - Successfully installed blessings 15:02:27 INFO - Cleaning up... 15:02:27 INFO - Return code: 0 15:02:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:27 INFO - Reading from file tmpfile_stdout 15:02:27 INFO - Current package versions: 15:02:27 INFO - argparse == 1.2.1 15:02:27 INFO - blessings == 1.6 15:02:27 INFO - blobuploader == 1.2.4 15:02:27 INFO - docopt == 0.6.1 15:02:27 INFO - functools32 == 3.2.3-2 15:02:27 INFO - jsonschema == 2.5.1 15:02:27 INFO - manifestparser == 1.1 15:02:27 INFO - mozInstall == 1.13 15:02:27 INFO - mozcrash == 1.0 15:02:27 INFO - mozdebug == 0.1 15:02:27 INFO - mozdevice == 0.51 15:02:27 INFO - mozfile == 1.2 15:02:27 INFO - mozhttpd == 0.7 15:02:27 INFO - mozinfo == 0.10 15:02:27 INFO - mozleak == 0.1 15:02:27 INFO - mozlog == 3.5 15:02:27 INFO - moznetwork == 0.27 15:02:27 INFO - mozprocess == 0.25 15:02:27 INFO - mozprofile == 0.28 15:02:27 INFO - mozrunner == 6.13 15:02:27 INFO - mozscreenshot == 0.1 15:02:27 INFO - mozsystemmonitor == 0.3 15:02:27 INFO - moztest == 0.8 15:02:27 INFO - mozversion == 1.4 15:02:27 INFO - psutil == 3.1.1 15:02:27 INFO - requests == 1.2.3 15:02:27 INFO - wsgiref == 0.1.2 15:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:02:27 INFO - Using env: {'DISPLAY': ':0', 15:02:27 INFO - 'HOME': '/home/cltbld', 15:02:27 INFO - 'LANG': 'en_US.UTF-8', 15:02:27 INFO - 'LANGUAGE': 'en_US:en', 15:02:27 INFO - 'LOGNAME': 'cltbld', 15:02:27 INFO - 'MAIL': '/var/mail/cltbld', 15:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:27 INFO - 'MOZ_NO_REMOTE': '1', 15:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:27 INFO - 'NO_EM_RESTART': '1', 15:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:27 INFO - 'PWD': '/builds/slave/test', 15:02:27 INFO - 'SHELL': '/bin/bash', 15:02:27 INFO - 'SHLVL': '1', 15:02:27 INFO - 'TERM': 'linux', 15:02:27 INFO - 'TMOUT': '86400', 15:02:27 INFO - 'USER': 'cltbld', 15:02:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:27 INFO - '_': '/tools/buildbot/bin/python'} 15:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:02:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:02:29 INFO - Installing collected packages: simplejson 15:02:29 INFO - Running setup.py install for simplejson 15:02:29 INFO - building 'simplejson._speedups' extension 15:02:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:02:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:02:30 INFO - Successfully installed simplejson 15:02:30 INFO - Cleaning up... 15:02:30 INFO - Return code: 0 15:02:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:30 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 0x16c01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1889a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:02:30 INFO - Using env: {'DISPLAY': ':0', 15:02:30 INFO - 'HOME': '/home/cltbld', 15:02:30 INFO - 'LANG': 'en_US.UTF-8', 15:02:30 INFO - 'LANGUAGE': 'en_US:en', 15:02:30 INFO - 'LOGNAME': 'cltbld', 15:02:30 INFO - 'MAIL': '/var/mail/cltbld', 15:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:30 INFO - 'MOZ_NO_REMOTE': '1', 15:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:30 INFO - 'NO_EM_RESTART': '1', 15:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:30 INFO - 'PWD': '/builds/slave/test', 15:02:30 INFO - 'SHELL': '/bin/bash', 15:02:30 INFO - 'SHLVL': '1', 15:02:30 INFO - 'TERM': 'linux', 15:02:30 INFO - 'TMOUT': '86400', 15:02:30 INFO - 'USER': 'cltbld', 15:02:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:30 INFO - '_': '/tools/buildbot/bin/python'} 15:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:02:30 INFO - Cleaning up... 15:02:30 INFO - Return code: 0 15:02:30 INFO - Running post-action listener: _resource_record_post_action 15:02:30 INFO - Running post-action listener: _start_resource_monitoring 15:02:30 INFO - Starting resource monitoring. 15:02:30 INFO - [mozharness: 2017-09-19 22:02:30.521491Z] Finished create-virtualenv step (success) 15:02:30 INFO - [mozharness: 2017-09-19 22:02:30.522008Z] Running install step. 15:02:30 INFO - Running pre-action listener: _resource_record_pre_action 15:02:30 INFO - Running main action method: install 15:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:30 INFO - Reading from file tmpfile_stdout 15:02:30 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:30 INFO - Reading from file tmpfile_stdout 15:02:30 INFO - Output received: 15:02:30 INFO - Usage: mozinstall [options] installer 15:02:30 INFO - Options: 15:02:30 INFO - -h, --help show this help message and exit 15:02:30 INFO - -d DEST, --destination=DEST 15:02:30 INFO - Directory to install application into. [default: 15:02:30 INFO - "/builds/slave/test"] 15:02:30 INFO - --app=APP Application being installed. [default: firefox] 15:02:30 INFO - mkdir: /builds/slave/test/build/application 15:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:02:48 INFO - Reading from file tmpfile_stdout 15:02:48 INFO - Output received: 15:02:48 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:48 INFO - Running post-action listener: _resource_record_post_action 15:02:48 INFO - [mozharness: 2017-09-19 22:02:48.674199Z] Finished install step (success) 15:02:48 INFO - [mozharness: 2017-09-19 22:02:48.674451Z] Running setup-mitmproxy step. 15:02:48 INFO - Running pre-action listener: _resource_record_pre_action 15:02:48 INFO - Running main action method: setup_mitmproxy 15:02:48 INFO - Skipping: mitmproxy is not required 15:02:48 INFO - Running post-action listener: _resource_record_post_action 15:02:48 INFO - [mozharness: 2017-09-19 22:02:48.675666Z] Finished setup-mitmproxy step (success) 15:02:48 INFO - [mozharness: 2017-09-19 22:02:48.675889Z] Running run-tests step. 15:02:48 INFO - Running pre-action listener: _resource_record_pre_action 15:02:48 INFO - Running pre-action listener: _set_gcov_prefix 15:02:48 INFO - Running main action method: run_tests 15:02:48 WARNING - Try message not found. 15:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:48 INFO - Python 2.7.3 15:02:48 INFO - Return code: 0 15:02:48 INFO - grabbing minidump binary from tooltool 15:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:48 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 0x1a30090>, '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 0x1a30d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:02:48 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:02:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:02:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:48 INFO - Return code: 0 15:02:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:48 INFO - ENV: RUST_BACKTRACE is now full 15:02:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 15:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 15:02:48 INFO - Using env: {'DISPLAY': ':0', 15:02:48 INFO - 'HOME': '/home/cltbld', 15:02:48 INFO - 'LANG': 'en_US.UTF-8', 15:02:48 INFO - 'LANGUAGE': 'en_US:en', 15:02:48 INFO - 'LOGNAME': 'cltbld', 15:02:48 INFO - 'MAIL': '/var/mail/cltbld', 15:02:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:48 INFO - 'MOZ_NO_REMOTE': '1', 15:02:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:48 INFO - 'NO_EM_RESTART': '1', 15:02:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:48 INFO - 'PWD': '/builds/slave/test', 15:02:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:48 INFO - 'RUST_BACKTRACE': 'full', 15:02:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:02:48 INFO - 'SHELL': '/bin/bash', 15:02:48 INFO - 'SHLVL': '1', 15:02:48 INFO - 'TERM': 'linux', 15:02:48 INFO - 'TMOUT': '86400', 15:02:48 INFO - 'USER': 'cltbld', 15:02:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:48 INFO - '_': '/tools/buildbot/bin/python'} 15:02:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 15:02:49 INFO - mozversion application_buildid: 20170919210608 15:02:49 INFO - mozversion application_changeset: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f 15:02:49 INFO - mozversion application_display_name: Nightly 15:02:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:49 INFO - mozversion application_name: Firefox 15:02:49 INFO - mozversion application_remotingname: firefox 15:02:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:02:49 INFO - mozversion application_vendor: Mozilla 15:02:49 INFO - mozversion application_version: 57.0a1 15:02:49 INFO - mozversion platform_buildid: 20170919210608 15:02:49 INFO - mozversion platform_changeset: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f 15:02:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:02:49 INFO - mozversion platform_version: 57.0a1 15:02:49 INFO - using testdate: 1505858569 15:02:49 INFO - actual date: 1505858569 15:02:49 INFO - starting webserver on 'localhost:35037' 15:02:49 INFO - SUITE-START | Running 2 tests 15:02:49 INFO - TEST-START | dromaeo_css 15:02:49 INFO - Initialising browser for dromaeo_css test... 15:02:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35037/getInfo.html -profile /tmp/tmpi1VZCJ/profile 15:02:49 INFO - TEST-INFO | started process 24246 (/builds/slave/test/build/application/firefox/firefox http://localhost:35037/getInfo.html) 15:02:55 INFO - TEST-INFO | 24246: exit 0 15:02:55 INFO - Browser initialized. 15:02:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:55 INFO - Using env: {'DISPLAY': ':0', 15:02:55 INFO - 'HOME': '/home/cltbld', 15:02:55 INFO - 'JSGC_DISABLE_POISONING': '1', 15:02:55 INFO - 'LANG': 'en_US.UTF-8', 15:02:55 INFO - 'LANGUAGE': 'en_US:en', 15:02:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:02:55 INFO - 'LOGNAME': 'cltbld', 15:02:55 INFO - 'MAIL': '/var/mail/cltbld', 15:02:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:55 INFO - 'MOZ_CRASHREPORTER': '1', 15:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:02:55 INFO - 'MOZ_NO_REMOTE': '1', 15:02:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:55 INFO - 'NO_EM_RESTART': '1', 15:02:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:55 INFO - 'PWD': '/builds/slave/test', 15:02:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:55 INFO - 'RUST_BACKTRACE': 'full', 15:02:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:02:55 INFO - 'SHELL': '/bin/bash', 15:02:55 INFO - 'SHLVL': '1', 15:02:55 INFO - 'STYLO_FORCE_DISABLED': '1', 15:02:55 INFO - 'TERM': 'linux', 15:02:55 INFO - 'TMOUT': '86400', 15:02:55 INFO - 'USER': 'cltbld', 15:02:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:55 INFO - '_': '/tools/buildbot/bin/python'} 15:02:55 INFO - TEST-INFO | started process 24481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1VZCJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:56 INFO - PID 24481 | 15:02:56 INFO - PID 24481 | (/builds/slave/test/build/application/firefox/firefox:24530): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:02:56 INFO - PID 24481 | 15:03:06 INFO - PID 24481 | RSS: Main: 154169344 15:03:06 INFO - PID 24481 | 15:06:03 INFO - PID 24481 | Cycle 1(1): loaded http://localhost:35037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35037/tests/dromaeo/cssquery-ext.html) 15:06:05 INFO - PID 24481 | RSS: Main: 154980352 15:06:05 INFO - PID 24481 | 15:09:06 INFO - PID 24481 | Cycle 1(1): loaded http://localhost:35037/tests/dromaeo/cssquery-ext.html (next: http://localhost:35037/tests/dromaeo/cssquery-jquery.html) 15:09:07 INFO - PID 24481 | RSS: Main: 154714112 15:09:07 INFO - PID 24481 | 15:12:09 INFO - PID 24481 | Cycle 1(1): loaded http://localhost:35037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35037/tests/dromaeo/cssquery-mootools.html) 15:12:09 INFO - PID 24481 | RSS: Main: 156762112 15:12:09 INFO - PID 24481 | 15:15:11 INFO - PID 24481 | Cycle 1(1): loaded http://localhost:35037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35037/tests/dromaeo/cssquery-prototype.html) 15:15:12 INFO - PID 24481 | RSS: Main: 155443200 15:15:12 INFO - PID 24481 | 15:18:15 INFO - PID 24481 | Cycle 1(1): loaded http://localhost:35037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35037/tests/dromaeo/cssquery-yui.html) 15:18:16 INFO - PID 24481 | RSS: Main: 156717056 15:18:16 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | Cycle 1(1): loaded http://localhost:35037/tests/dromaeo/cssquery-yui.html (next: http://localhost:35037/tests/dromaeo/cssquery-dojo.html) 15:21:17 INFO - PID 24481 | RSS: Main: 159383552 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | __start_tp_report 15:21:17 INFO - PID 24481 | _x_x_mozilla_page_load 15:21:17 INFO - PID 24481 | _x_x_mozilla_page_load_details 15:21:17 INFO - PID 24481 | |i|pagename|runs| 15:21:17 INFO - PID 24481 | |0;dojo.html;3126.546650735643;3143.669914658962;3151.8108913465185;3170.857311420987;3181.0297859152965;6164.4143806338325;6241.750329986795;6250.187475628168;6350.587211831228;6362.936370636292;6239;6266.279377871546;6267.153934218879;6312.747490100391;6324.9367506324925;5764.682942438164;5773.624714393562;5791.044477661181;5795.594308398393;5819.82540523785;5753.884922301551;5815.912761308584;5853.326867410238;5870.794522191724;5905.291365036202;5833.648468443383;5837.1536127261525;5893.58744887858;5905.527557795387;5947.434993675615;5569.972150139264;5729.570282228808;5733.226014488074;5826.737796799154;5944.227250457435;5751.942480575182;5798.594098413113;5806.796762113348;5832.416758324176;5846.473817356416;6201.441870231656;6287.308396076428;6288.591241569329;6345.143405640272;6359.777407790752;6705.094812200388;6724.966375168142;6749.595024298558;6749.7300107995625;6803.455723542104;6770.72917083316;6788.456923446161;6830;6832.829179270509;6842.110525631686;6218.564700470969;6223.782167624111;6289.465395441439;6311.274203466614;6332.461740752042;6791.694373753193;6908.723651054002;6913.308669133147;6950.965245173843;7037;6573.112629795012;6578.868422631521;6580.76967306142;6584.012398140318;6585.9012114818315;6628.53600247978;6702.162229721285;6711.865762684719;6714.52998290115;6722.260551339349;6654.700538475683;6664.86670266592;6710.328967103348;6716.597004179765;6744.83137921546;6721.1598550181225;6750.8649827004165;6755.020522024377;6782;6827.317268273133;5266.4470230626;5293.153095504701;5331.626786124934;5331.9869224847935;5333.57331413486;4540.523245059288;4577.542245775396;4622.583967442946;4629.837955671535;4714.481407045222;5745.396733343023;5749.080147176432;5754.367019627837;5758.2514273144225;5776.480116789509;6678.3989440950545;6703.430208432241;6763.951587503945;6775.559588626724;6810.9318906810295;5638.85902852432;5657.57568182388;5698.287714035746;5707.629004114802;5747.6838773867;5761.251037365199;5782;5782.855428614318;5784.074548072288;5791.710414479344;6431;6481.449076828428;6482.935170648233;6493.902591461132;6554.63949482783;6652.467802575879;6731.326867313425;6800.65996700163;6823.147106611674;6823.351781580742;6464.482841372773;6467.935320646733;6550.017497375432;6564.9671751640935;6580.374864387875;6516.348365163446;6602.735890564323;6603.108580341593;6634.601923884582;6706.329367063255;6624.403803657694;6686.765963191265;6701.899471508029;6706.926891697305;6717.059611654275;6468.611883287018;6470.158879345655;6486.383793539606;6547.672616369067;6600.768973085919;6652.301508341748;6660.6336651484635;6663.13379260693;6666.100076489612;6666.266710661726;6423.389777971085;6441.645709486023;6446.806595802133;6530.967345163243;6548.967255163694;6394.520410969103;6488.545801793829;6568.770093046721;6677.866442671217;6694.899576506259;6368.299487056513;6379.330170332234;6439.903401448888;6458.063580780667;6462.095306657166 15:21:17 INFO - PID 24481 | |1;ext.html;858.7552547523954;889.8665200219968;891.313688459886;892.879461272728;900.7612982559618;38723.419148712754;39644.60355396445;42320.153596928045;42440.57559424405;42706.145877082476;38511.61488385115;38796;38811.22377552447;38817.805910970405;38948.22103557927;7113.679884405215;7225.963870180642;7237.276272372773;7251.093613298338;7833.060032796044;7801.609919504031;7916.247956444128;7917.802054948644;7922.524648521078;7923.445358824884;7918.247766462206;7956.840863182733;7961.084475285358;7978.840423191533;7992.720254791084;7901.091374491921;7932.801679957989;7947.96026019872;7956.085050219241;7966.601669916481;7841.607919603997;7898.407619428566;7907.051153861516;7930.167332430127;7937.920620793833;37249.44125838114;37484.625153748384;37542.24915501675;37570.62429375726;37576.62423375758;3519.771214871025;3571.928561428757;3575.570931488212;3578.4632305154173;3582.39099353108;31522.054338369886;31583.84208078968;31594.526082108787;31701.52447713286;31719.682803171905;5027.899442011139;5109.054824857413;5136.409312929024;5147.510986456281;5233.816816411445;185499;186030;186554;186725;186778.06610966995;41760.164796703895;48793;48972.26541601879;48980.51019489831;49078;44210.33684494735;49836.75081624569;50487.24269135966;50638.493615064115;50654.49345506571;16255.918720406322;16279.186040697918;16295.34818607266;16392.918035409748;16405.507834764976;13305.40125694346;13327.200367977952;13327.800082998763;13330.933345333211;13331.866681333062;13852.584422467342;13891.86108138926;13931.164130152223;13976.811970982377;14048.016638835388;5712.714364281769;5730.19777231188;5738.598298119092;5806.677329068407;5825.650460972355;1014.5688082564881;1028.290479569095;1046.612753281291;1052.6894566103017;1059.2796898109204;23234.767652323597;23437.531249375257;23445.296641100795;23484.882575587013;23720.288391348287;1115.7043383503378;1127.1490025031048;1135.7558125003163;1135.926164799302;1149.68383694483;12230.449629766681;12431.191972521758;12456.252624842538;12556.874431255754;12661.430235639235;211127;211205;211214;211517;212054;52763.73618131885;52931.735341323816;53011.46988530143;53089;53155.73422132865;1423.686788906439;1478.5564330700747;1492.6492274315526;1498.243387089513;1507.8039854818803;23265.651015234445;23266;23266.651000234673;23330.300090997298;23518.76481235166;37702.057448564;37718.62281377261;37808.810955945046;37815.24369512539;37887.62112378951;176681;176723;177792;178849;179612;30930.381392372477;31415.52876706897;33589.83205084057;33610.327793444485;33661.49507757337;42928.35607465953;42992.57007430011;43138.13723725571;43201.13597728091;43231.78384108059;31668.841655791573;31756.364872701954;31786.841065794524;31841.522377164823;32627;31753.5236971441;31773.841130794197;31869.840650797527;31963.680363196072;32126.196845078124;35612.10969725777;35632.46551301784;35805.283894322485;35992.460113098845;36026;30950.690493094782;31015.224619384695;31216;31301;31702.207444814063;23535.646965295193;23616.17343392973;23700.644490332314;23819.404514887265;24142.275731728078 15:21:17 INFO - PID 24481 | |2;jquery.html;565.417619851553;571.1404336473606;573.8020382967876;578.9392113828048;580.1848402993793;21975.560488790234;22751.772482275173;22789;22815.657765133536;22829.657555136644;23302.41743956402;24241.27276181713;24271.27186184413;24677.50644987099;24794.380140496498;6422.389872962073;6624.304448032959;6649.035889795977;6649.734010639569;6684.465242780566;6523.93476065238;6673.165854268216;6683.598984060972;6691;6699.397054265115;6301.117843501914;6572.0141978703095;6581.440577550914;6583.9012414813815;6617.205935287772;6574.3754343337305;6637.1703537057865;6637.601743895358;6642.169728783902;6646.0363247329105;5980.073088671263;6060.090986352083;6104.389561043905;6166.445019948182;6185.103160041769;28215.43569128606;28755;28887.855560722062;28944.565831512544;28946.855265723538;2037.0934933954395;2064.9277275295444;2065.401033700225;2065.7211276477633;2070.896455177235;17516.38692645751;19619.313324033734;19750.70373944392;19959.600807983905;19998.300059497848;2364.7635236476217;2433.209207007712;2440.3533063737946;2443.2059580636364;2448.669429626995;118060;124565;132408.33795831056;141065.294673527;141673;14526.631168330308;14533;14644.121352718657;14865.851341486446;14941.103533788008;22315.33054008382;22914;22917.770822291564;22928.19751308696;23068.53862922732;10130.493475326204;10355;10372;10457.372557646566;10475.319104258198;9597.23222142227;9627.277954153327;9698.36960597559;9700.27247956406;9831.311808173503;8779.69271075522;8866.024737278894;9173.862392063991;9236.907630923739;9240.445573265491;2630.355562887105;2663.9866800665873;2758.2898602866353;2819.9414427468064;2838.68774434812;960.9231261499064;970.9514524273758;981.283662926068;981.9361741486781;996.7458298133929;18283.72574411385;18349.17428715711;18426.327599102468;18715.438536843918;18776.248950042118;1018.6231094494937;1025.43601019439;1035.3735989726258;1050.9264351495474;1059.597353005853;10278.743031424274;10404.58381664725;10532.315399499008;10609.946950265354;10627.256092073636;490718;510897;512280;512726;513147;107885.46057269664;108156.45921770498;108803.45598271958;110028;110870;1049.5959055763585;1091.476091476096;1106.1758989552834;1137.4995002199005;1160.6227975907864;19228;19400.611987759883;19584.51038723986;19623.411297661092;19796.406107816787;53145.202821956926;53877;53968;54503.45496544984;54823;66657.66671166613;66807;67424.6628766853;67454.66272668606;67693.66153169202;13902;14249.501267456004;14265.928670356581;14323.069000514934;14351.282435877956;21919.12323507042;22073.11707531745;22132.778672213073;22133.225337113123;22321.77678223197;17483.300667973137;17719.202635881673;17881.46355609334;17899.37352192667;17982;15893.364265429253;16155.919220403823;16211.918940405223;16461.753073703665;16472.917635412225;17843.464696059138;18401.171947262137;18679.533011674815;18812.717809233145;18826.24695012184;13882;13945.372458239606;14062.859371406155;14087.859121408655;14125.223112728898;17569.82430175733;17993.910030449762;18030.90984545069;18141;18141.092945352415 15:21:17 INFO - PID 24481 | |3;mootools.html;1345.3004437692398;1402.1587047771338;1418.7729963205888;1419.4322271091569;1422.3741553716363;14277.143371397711;14904.627384315383;14913.776293355595;14916.105033697986;14946.177960212184;14610.780838287434;14633.634159146026;14673.706525869502;14748.188849613267;14751;2690.3812123211674;2719.2386131883054;2742.520058989679;2752.8073034887566;2772.88908443662;2704.9323766905786;2709.336212627909;2727.5772255300462;2740.9177724668293;2742.0676969830256;2708.647875776156;2801.243664210662;2808.606795048695;2809.0730059080556;2816.380396312808;2741.6984131745494;2755.1596762987283;2768.9723102768917;2780.694123646397;2780.708025657297;2690.9461810763673;2702.6216329713857;2715.253305341027;2717.062613398394;2805.5651374037056;14388.208648524327;14510;14510.782338264935;14518.854811451962;14541.200233987127;7865.134835168127;8147.185281471865;8152.144024877421;8154.8776768348525;8156.673733050671;5444.897635924431;5551.9722401387735;5599.692016939067;5673.432656734293;5691.317041954951;1876.6152938647544;1895.75355203824;1914.9904250478658;1945.5525229197222;1945.6692362298443;24132.51734965291;24180.637290440656;24256.757432425802;24271.514569708685;24317.513649727083;6140.846478838065;6485.156929599122;6581.802545923534;6688.899666505006;6711.765088221889;16731.163441828103;16771.748423773653;18504.629907402046;19323.4202973911;19454.416367509;7999.320057795153;8223.17768223173;8224;8227.465214761141;8229.094799572042;7156.320149585781;7209;7265.491415600963;7310.817229569197;7333;5424.186372044225;5590.664560126405;5664.971675141598;5672.177534257509;5682.40334764852;1726.2318268370454;1751.6584266067994;1772.0696634267113;1775.0858307971405;1827.5979284557377;870.1559487297311;885.9734207973771;901.5402144906145;903.5301643145527;907.6278725722422;7150.678219480136;7258.3104605062435;7264.237255088246;7294.927050729425;7295.452841036943;686.1217641418991;720.1969803668871;720.8882623193414;722.9746958856415;731.5208538407352;4810.5327874997765;5237.973810130925;5253.343332083489;5375.377175628956;5456.372517160498;19527.707084393747;20017.899910500353;20535.4866128348;20538.486537836674;20836.37490875276;19443.611127777363;19569.706454403196;20195.293164739163;20335.491612709506;20383.694244586342;10670.253082284165;10744.946275268574;10911.672649820519;10912.745034321155;10932;7850.725224617111;8003.3597312213715;8066.556339401154;8087.433879628369;8098.83802323962;16858.241379137722;16970.151492425575;17258.654826903643;17393.739093913347;17441.56396090108;17120.828791711923;17478.91260543689;17617.29530818804;17623.325784050496;17794.733079004083;11701.941490292495;11764;11765.647030588754;11768.70578235551;11774.116941229271;12788.104832661624;13089.803652945404;13137.868621313664;13205.867941320465;13218.933905330412;10918.399488027917;10978;11229.831552526883;11281.32312061279;11304.886951130384;10689.198310126616;10795.136389088697;10888.455577221266;10935.83596246041;10936.50785714629;9407.623695052122;9427.104425079606;9447.669331573363;9474.905250947679;9539.713808585753;7040.119985001875;7106.893396598952;7116.964415177891;7219.530730502501;7244.710211591688;7278.745243916437;7400.777976660709;7455.478116531791;7476.4392670551015;7490.4007679386605 15:21:17 INFO - PID 24481 | |4;prototype.html;499.2022552196001;500.9547900701834;520.5211205690764;523.7381309345327;526.8656492594388;6227.065940108986;6233;6275.7489700411925;6306.180196574451;6314.811020434674;6095.146679464868;6244.687765611724;6291.20700600329;6316.968415157918;6328.430441260286;5193.818216362428;5218.295530103444;5220.582353411718;5221.660592061523;5231.346081739783;4737.526247375269;5100.183970564711;5171.586273098162;5195.740212989354;5251.715503755879;4845.940475298002;4868.148074087038;4889.504004636684;4913.582345500637;4914.913064977749;4881.926771098437;4894.877628059309;4903.141950158708;4924.409070911478;4935.580475659555;4329;4407.1185762847235;4455.242608756519;4478.08199319142;4507.639388848885;5926.555508336892;6005.279366476051;6071.301800292978;6082.300535438437;6106;5670.206171136044;5678.574106941955;5683.5737319700775;5698.914516282259;5699.629524080921;6482.448991835699;6505.6421896795655;6534.477241820643;6559.311272316386;6562.77030303937;4617.145828021827;4859.805607775685;4875.951240487585;4889.657723959324;4896.632752543574;6560.179977502812;6692.096566963495;6717.966410167918;6785.966070169667;6852.486063545254;4930.556249937523;4938.530839570235;4981.2030075187795;4995.750212489361;5013.373328333958;5011.34852469184;5015.724135172601;5024.61822998671;5058.949410505921;5081.822136225288;5562.276904002454;5592.832215033555;5602.355729091207;5610.72765529961;5664.915026274609;6482.513811464159;6486.610803351814;6542.182227221598;6546.18172728409;6576.86846263072;1727.153694689593;1732.7400889866622;1745.6945034619146;1750.2298988445043;1768.2484943898792;1156.7166044319197;1207.9396030198454;1226.51552636708;1230.267990545624;1241.6088931986396;5565.16522521625;5589.4070189995655;5641.689707066151;5651.208830763697;5657.2928383952;6538.117354157128;6584.8024559263295;6631.436327912182;6658.234303055211;6726.932730672728;5521.144222645416;5528.889422211533;5529.30883639545;5587.357453892773;5612.7754889803955;3502;3518.296340731864;3520.559930008749;3530.5763308403157;3538.6461353864925;6309.211348581427;6348.968255158787;6370.840728981812;6396.488280937514;6406.35936406365;6754.358335958076;6786.117804685359;6809.829754256183;6849.04113424121;6885.655717214119;5898.1661919752505;6308.243010838729;6329.873402531924;6337.162222955476;6459.677016149174;6493.837654058498;6558.573692709959;6567.573107747981;6587.4848784780725;6593.967030164818;6357.618542887441;6421.614703117828;6448.806535803933;6474.967625161844;6575.835604109936;6220.4759833841;6289.654069026247;6317;6374.107624932421;6420.6468644225015;4921.458639549575;4946.752662366795;4970.378702662168;4974.253861920741;5006.69959802413;6341.143945567289;6615;6660.334916270932;6668.633225172468;6758.290379510081;6224.346443623354;6428.517861160338;6445.581037232565;6479.773207937699;6561.278259391559;6355.5551111421755;6455.644939528371;6486.416222539994;6487.632014314647;6515.055316978916;6304;6310.842228944313;6319.462845657987;6349.6507692077375;6423.903641445476;6376.681165941777;6466.256380516113;6491.604305074432;6502.73989040452;6518.73925042993;6290.968545157245;6299.622022678654;6306.180196574416;6331.6517591531065;6334.398232167937 15:21:17 INFO - PID 24481 | |5;yui.html;886.3219636977717;914.9817003659927;938.3853575907779;944.7732544189397;949.672363034753;19064.71402928957;19825;19976.001199939998;20031.399058028263;20032.399028029147;17363.392206391836;17524.649507009854;17788.64422711548;18245;18476.076196190203;957.5978089202534;975.3172779054655;977.4721650308825;977.5454413697629;978.4618459847092;977.9364341317792;992.4987881120024;994.4530508220486;996.8405055191171;997.6209040564612;1047.7223535763028;1061.2147011211725;1061.7345663584103;1062.0388548363744;1062.2139616683676;994.6767300627325;1048.8951104889527;1051.8527406163143;1054.5518154784186;1055.978880422395;744.3598505285504;746.1233051164913;746.7946314763429;751.0649241694126;751.3087959077661;18133.36533221344;18228.63542729138;18269.45191644253;18275.36036238725;18282.817171828377;21156.682649760267;21341.253056143116;22015.889920550453;22222.444438888997;22241;16136.596585085466;17242;17290.7406388903;17335.566610834703;17532.91233543837;3695.1685870678884;3715.442683597482;3728.105254738843;3729.869454569104;3732.365497865342;120582;127085.36457317747;127635.36182319121;128415.35792320978;128805;15404.152771597446;15658.373665053497;15681.294341754648;15752.212389380486;15838.76241856373;31031.379372412877;31501.36997260042;31558.211044724067;31606.683933160835;31624.841875790473;8305.584720763938;8391.664333426717;8434.030086540004;8448.07071222165;8469.957650211833;3900.3369427197445;3975.840966361371;3991.022199561126;3999.480067591253;4012.879613611596;5246.108161612535;5316.9202461963105;5318.946810531846;5396.433374495621;5407.540359069523;976.9804603908024;996.6760802739138;1000.0999100809184;1006.9194464442827;1008.3395376028712;621.1583304622262;633.2749002392327;636.5734957578434;642.6754488983128;651.0007139041643;10820.458977051116;11258.380789056517;11362.886371136183;11485.770284594428;11604.593839215588;609.4697613076563;613.5980932489226;615.2125279642065;619.4765423217374;640.5292110298926;5296.788128474818;5322.600804939645;5348.224507446398;5362.570994320445;5446.128619420953;123414;123651.38174309251;124299;125305.37347313204;129031;107494;108429;111027;112628.43685781682;115156.42421788005;91727.54136229276;93402;95284;95858;96467;9803.803923921625;9944.502774861083;9996.050375214343;10070.647527336509;10083.949580252052;42059.369109463994;42693.78653106715;44707;44786.3282050776;45719.77140114278;55664;56132.71933640305;58299.4170058294;58799.41200587939;58814.705926470095;14615.561533154023;14668.77996830027;14678.559643210721;14761.483348082766;14804.703905922037;16566.420175293806;16633.916830416256;16693.749593756347;16800.32798688088;16895.662086758442;15092.698146036799;15763.290651920463;15925.920370398075;15937.12345820991;15988.760168597713;16029.198540072717;16064.196790160211;16166.110863902599;16274.755878661592;16404.589885252964;14089.647758805702;14150.716985660023;14186;14286.357113930106;14392.06451580644;10008;10256.48717564104;10321.74195645115;10351.844722329322;10405.843912341472;10447.94776026115;10583.523741431809;10614.89385106139;10821.621243256448;10842.186835987175 15:21:17 INFO - PID 24481 | __end_tp_report 15:21:17 INFO - PID 24481 | __start_cc_report 15:21:17 INFO - PID 24481 | _x_x_mozilla_cycle_collect,292 15:21:17 INFO - PID 24481 | __end_cc_report 15:21:17 INFO - PID 24481 | __startTimestamp1505859677894__endTimestamp 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | ------- Summary: start ------- 15:21:17 INFO - PID 24481 | Number of tests: 6 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | [#0] dojo.html Cycles:165 Average:6188.12 Median:6446.81 stddev:740.77 (11.5%) stddev-sans-first:703.03 15:21:17 INFO - PID 24481 | Values: 3126.5 3143.7 3151.8 3170.9 3181.0 6164.4 6241.8 6250.2 6350.6 6362.9 6239.0 6266.3 6267.2 6312.7 6324.9 5764.7 5773.6 5791.0 5795.6 5819.8 5753.9 5815.9 5853.3 5870.8 5905.3 5833.6 5837.2 5893.6 5905.5 5947.4 5570.0 5729.6 5733.2 5826.7 5944.2 5751.9 5798.6 5806.8 5832.4 5846.5 6201.4 6287.3 6288.6 6345.1 6359.8 6705.1 6725.0 6749.6 6749.7 6803.5 6770.7 6788.5 6830.0 6832.8 6842.1 6218.6 6223.8 6289.5 6311.3 6332.5 6791.7 6908.7 6913.3 6951.0 7037.0 6573.1 6578.9 6580.8 6584.0 6585.9 6628.5 6702.2 6711.9 6714.5 6722.3 6654.7 6664.9 6710.3 6716.6 6744.8 6721.2 6750.9 6755.0 6782.0 6827.3 5266.4 5293.2 5331.6 5332.0 5333.6 4540.5 4577.5 4622.6 4629.8 4714.5 5745.4 5749.1 5754.4 5758.3 5776.5 6678.4 6703.4 6764.0 6775.6 6810.9 5638.9 5657.6 5698.3 5707.6 5747.7 5761.3 5782.0 5782.9 5784.1 5791.7 6431.0 6481.4 6482.9 6493.9 6554.6 6652.5 6731.3 6800.7 6823.1 6823.4 6464.5 6467.9 6550.0 6565.0 6580.4 6516.3 6602.7 6603.1 6634.6 6706.3 6624.4 6686.8 6701.9 6706.9 6717.1 6468.6 6470.2 6486.4 6547.7 6600.8 6652.3 6660.6 6663.1 6666.1 6666.3 6423.4 6441.6 6446.8 6531.0 6549.0 6394.5 6488.5 6568.8 6677.9 6694.9 6368.3 6379.3 6439.9 6458.1 6462.1 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | [#1] ext.html Cycles:180 Average:36207.12 Median:19565.94 stddev:49711.22 (254.1%) stddev-sans-first:49779.81 15:21:17 INFO - PID 24481 | Values: 858.8 889.9 891.3 892.9 900.8 38723.4 39644.6 42320.2 42440.6 42706.1 38511.6 38796.0 38811.2 38817.8 38948.2 7113.7 7226.0 7237.3 7251.1 7833.1 7801.6 7916.2 7917.8 7922.5 7923.4 7918.2 7956.8 7961.1 7978.8 7992.7 7901.1 7932.8 7948.0 7956.1 7966.6 7841.6 7898.4 7907.1 7930.2 7937.9 37249.4 37484.6 37542.2 37570.6 37576.6 3519.8 3571.9 3575.6 3578.5 3582.4 31522.1 31583.8 31594.5 31701.5 31719.7 5027.9 5109.1 5136.4 5147.5 5233.8 185499.0 186030.0 186554.0 186725.0 186778.1 41760.2 48793.0 48972.3 48980.5 49078.0 44210.3 49836.8 50487.2 50638.5 50654.5 16255.9 16279.2 16295.3 16392.9 16405.5 13305.4 13327.2 13327.8 13330.9 13331.9 13852.6 13891.9 13931.2 13976.8 14048.0 5712.7 5730.2 5738.6 5806.7 5825.7 1014.6 1028.3 1046.6 1052.7 1059.3 23234.8 23437.5 23445.3 23484.9 23720.3 1115.7 1127.1 1135.8 1135.9 1149.7 12230.4 12431.2 12456.3 12556.9 12661.4 211127.0 211205.0 211214.0 211517.0 212054.0 52763.7 52931.7 53011.5 53089.0 53155.7 1423.7 1478.6 1492.6 1498.2 1507.8 23265.7 23266.0 23266.7 23330.3 23518.8 37702.1 37718.6 37808.8 37815.2 37887.6 176681.0 176723.0 177792.0 178849.0 179612.0 30930.4 31415.5 33589.8 33610.3 33661.5 42928.4 42992.6 43138.1 43201.1 43231.8 31668.8 31756.4 31786.8 31841.5 32627.0 31753.5 31773.8 31869.8 31963.7 32126.2 35612.1 35632.5 35805.3 35992.5 36026.0 30950.7 31015.2 31216.0 31301.0 31702.2 23535.6 23616.2 23700.6 23819.4 24142.3 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | [#2] jquery.html Cycles:180 Average:34567.34 Median:22318.55 stddev:84949.44 (380.6%) stddev-sans-first:85149.39 15:21:17 INFO - PID 24481 | Values: 565.4 571.1 573.8 578.9 580.2 21975.6 22751.8 22789.0 22815.7 22829.7 23302.4 24241.3 24271.3 24677.5 24794.4 6422.4 6624.3 6649.0 6649.7 6684.5 6523.9 6673.2 6683.6 6691.0 6699.4 6301.1 6572.0 6581.4 6583.9 6617.2 6574.4 6637.2 6637.6 6642.2 6646.0 5980.1 6060.1 6104.4 6166.4 6185.1 28215.4 28755.0 28887.9 28944.6 28946.9 2037.1 2064.9 2065.4 2065.7 2070.9 17516.4 19619.3 19750.7 19959.6 19998.3 2364.8 2433.2 2440.4 2443.2 2448.7 118060.0 124565.0 132408.3 141065.3 141673.0 14526.6 14533.0 14644.1 14865.9 14941.1 22315.3 22914.0 22917.8 22928.2 23068.5 10130.5 10355.0 10372.0 10457.4 10475.3 9597.2 9627.3 9698.4 9700.3 9831.3 8779.7 8866.0 9173.9 9236.9 9240.4 2630.4 2664.0 2758.3 2819.9 2838.7 960.9 971.0 981.3 981.9 996.7 18283.7 18349.2 18426.3 18715.4 18776.2 1018.6 1025.4 1035.4 1050.9 1059.6 10278.7 10404.6 10532.3 10609.9 10627.3 490718.0 510897.0 512280.0 512726.0 513147.0 107885.5 108156.5 108803.5 110028.0 110870.0 1049.6 1091.5 1106.2 1137.5 1160.6 19228.0 19400.6 19584.5 19623.4 19796.4 53145.2 53877.0 53968.0 54503.5 54823.0 66657.7 66807.0 67424.7 67454.7 67693.7 13902.0 14249.5 14265.9 14323.1 14351.3 21919.1 22073.1 22132.8 22133.2 22321.8 17483.3 17719.2 17881.5 17899.4 17982.0 15893.4 16155.9 16211.9 16461.8 16472.9 17843.5 18401.2 18679.5 18812.7 18826.2 13882.0 13945.4 14062.9 14087.9 14125.2 17569.8 17993.9 18030.9 18141.0 18141.1 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | [#3] mootools.html Cycles:180 Average:9034.21 Median:2712.29 stddev:6221.58 (229.4%) stddev-sans-first:6212.21 15:21:17 INFO - PID 24481 | Values: 1345.3 1402.2 1418.8 1419.4 1422.4 14277.1 14904.6 14913.8 14916.1 14946.2 14610.8 14633.6 14673.7 14748.2 14751.0 2690.4 2719.2 2742.5 2752.8 2772.9 2704.9 2709.3 2727.6 2740.9 2742.1 2708.6 2801.2 2808.6 2809.1 2816.4 2741.7 2755.2 2769.0 2780.7 2780.7 2690.9 2702.6 2715.3 2717.1 2805.6 14388.2 14510.0 14510.8 14518.9 14541.2 7865.1 8147.2 8152.1 8154.9 8156.7 5444.9 5552.0 5599.7 5673.4 5691.3 1876.6 1895.8 1915.0 1945.6 1945.7 24132.5 24180.6 24256.8 24271.5 24317.5 6140.8 6485.2 6581.8 6688.9 6711.8 16731.2 16771.7 18504.6 19323.4 19454.4 7999.3 8223.2 8224.0 8227.5 8229.1 7156.3 7209.0 7265.5 7310.8 7333.0 5424.2 5590.7 5665.0 5672.2 5682.4 1726.2 1751.7 1772.1 1775.1 1827.6 870.2 886.0 901.5 903.5 907.6 7150.7 7258.3 7264.2 7294.9 7295.5 686.1 720.2 720.9 723.0 731.5 4810.5 5238.0 5253.3 5375.4 5456.4 19527.7 20017.9 20535.5 20538.5 20836.4 19443.6 19569.7 20195.3 20335.5 20383.7 10670.3 10744.9 10911.7 10912.7 10932.0 7850.7 8003.4 8066.6 8087.4 8098.8 16858.2 16970.2 17258.7 17393.7 17441.6 17120.8 17478.9 17617.3 17623.3 17794.7 11701.9 11764.0 11765.6 11768.7 11774.1 12788.1 13089.8 13137.9 13205.9 13218.9 10918.4 10978.0 11229.8 11281.3 11304.9 10689.2 10795.1 10888.5 10935.8 10936.5 9407.6 9427.1 9447.7 9474.9 9539.7 7040.1 7106.9 7117.0 7219.5 7244.7 7278.7 7400.8 7455.5 7476.4 7490.4 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | [#4] prototype.html Cycles:180 Average:5449.63 Median:6100.57 stddev:1515.19 (24.8%) stddev-sans-first:1473.18 15:21:17 INFO - PID 24481 | Values: 499.2 501.0 520.5 523.7 526.9 6227.1 6233.0 6275.7 6306.2 6314.8 6095.1 6244.7 6291.2 6317.0 6328.4 5193.8 5218.3 5220.6 5221.7 5231.3 4737.5 5100.2 5171.6 5195.7 5251.7 4845.9 4868.1 4889.5 4913.6 4914.9 4881.9 4894.9 4903.1 4924.4 4935.6 4329.0 4407.1 4455.2 4478.1 4507.6 5926.6 6005.3 6071.3 6082.3 6106.0 5670.2 5678.6 5683.6 5698.9 5699.6 6482.4 6505.6 6534.5 6559.3 6562.8 4617.1 4859.8 4876.0 4889.7 4896.6 6560.2 6692.1 6718.0 6786.0 6852.5 4930.6 4938.5 4981.2 4995.8 5013.4 5011.3 5015.7 5024.6 5058.9 5081.8 5562.3 5592.8 5602.4 5610.7 5664.9 6482.5 6486.6 6542.2 6546.2 6576.9 1727.2 1732.7 1745.7 1750.2 1768.2 1156.7 1207.9 1226.5 1230.3 1241.6 5565.2 5589.4 5641.7 5651.2 5657.3 6538.1 6584.8 6631.4 6658.2 6726.9 5521.1 5528.9 5529.3 5587.4 5612.8 3502.0 3518.3 3520.6 3530.6 3538.6 6309.2 6349.0 6370.8 6396.5 6406.4 6754.4 6786.1 6809.8 6849.0 6885.7 5898.2 6308.2 6329.9 6337.2 6459.7 6493.8 6558.6 6567.6 6587.5 6594.0 6357.6 6421.6 6448.8 6475.0 6575.8 6220.5 6289.7 6317.0 6374.1 6420.6 4921.5 4946.8 4970.4 4974.3 5006.7 6341.1 6615.0 6660.3 6668.6 6758.3 6224.3 6428.5 6445.6 6479.8 6561.3 6355.6 6455.6 6486.4 6487.6 6515.1 6304.0 6310.8 6319.5 6349.7 6423.9 6376.7 6466.3 6491.6 6502.7 6518.7 6291.0 6299.6 6306.2 6331.7 6334.4 15:21:17 INFO - PID 24481 | 15:21:17 INFO - PID 24481 | [#5] yui.html Cycles:180 Average:23755.46 Median:19900.50 stddev:34551.46 (173.6%) stddev-sans-first:34605.71 15:21:17 INFO - PID 24481 | Values: 886.3 915.0 938.4 944.8 949.7 19064.7 19825.0 19976.0 20031.4 20032.4 17363.4 17524.6 17788.6 18245.0 18476.1 957.6 975.3 977.5 977.5 978.5 977.9 992.5 994.5 996.8 997.6 1047.7 1061.2 1061.7 1062.0 1062.2 994.7 1048.9 1051.9 1054.6 1056.0 744.4 746.1 746.8 751.1 751.3 18133.4 18228.6 18269.5 18275.4 18282.8 21156.7 21341.3 22015.9 22222.4 22241.0 16136.6 17242.0 17290.7 17335.6 17532.9 3695.2 3715.4 3728.1 3729.9 3732.4 120582.0 127085.4 127635.4 128415.4 128805.0 15404.2 15658.4 15681.3 15752.2 15838.8 31031.4 31501.4 31558.2 31606.7 31624.8 8305.6 8391.7 8434.0 8448.1 8470.0 3900.3 3975.8 3991.0 3999.5 4012.9 5246.1 5316.9 5318.9 5396.4 5407.5 977.0 996.7 1000.1 1006.9 1008.3 621.2 633.3 636.6 642.7 651.0 10820.5 11258.4 11362.9 11485.8 11604.6 609.5 613.6 615.2 619.5 640.5 5296.8 5322.6 5348.2 5362.6 5446.1 123414.0 123651.4 124299.0 125305.4 129031.0 107494.0 108429.0 111027.0 112628.4 115156.4 91727.5 93402.0 95284.0 95858.0 96467.0 9803.8 9944.5 9996.1 10070.6 10083.9 42059.4 42693.8 44707.0 44786.3 45719.8 55664.0 56132.7 58299.4 58799.4 58814.7 14615.6 14668.8 14678.6 14761.5 14804.7 16566.4 16633.9 16693.7 16800.3 16895.7 15092.7 15763.3 15925.9 15937.1 15988.8 16029.2 16064.2 16166.1 16274.8 16404.6 14089.6 14150.7 14186.0 14286.4 14392.1 10008.0 10256.5 10321.7 10351.8 10405.8 10447.9 10583.5 10614.9 10821.6 10842.2 15:21:17 INFO - PID 24481 | -------- Summary: end -------- 15:21:17 INFO - PID 24481 | 15:21:18 INFO - TEST-INFO | 24481: exit 0 15:21:18 INFO - TEST-OK | dromaeo_css | took 1109633ms 15:21:18 INFO - TEST-START | kraken 15:21:18 INFO - Initialising browser for kraken test... 15:21:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35037/getInfo.html -profile /tmp/tmp_9mgYI/profile 15:21:18 INFO - TEST-INFO | started process 24845 (/builds/slave/test/build/application/firefox/firefox http://localhost:35037/getInfo.html) 15:21:24 INFO - TEST-INFO | 24845: exit 0 15:21:24 INFO - Browser initialized. 15:21:24 INFO - Running cycle 1/1 for kraken test... 15:21:24 INFO - Using env: {'DISPLAY': ':0', 15:21:24 INFO - 'HOME': '/home/cltbld', 15:21:24 INFO - 'JSGC_DISABLE_POISONING': '1', 15:21:24 INFO - 'LANG': 'en_US.UTF-8', 15:21:24 INFO - 'LANGUAGE': 'en_US:en', 15:21:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:21:24 INFO - 'LOGNAME': 'cltbld', 15:21:24 INFO - 'MAIL': '/var/mail/cltbld', 15:21:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:24 INFO - 'MOZ_CRASHREPORTER': '1', 15:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:21:24 INFO - 'MOZ_NO_REMOTE': '1', 15:21:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:24 INFO - 'NO_EM_RESTART': '1', 15:21:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:24 INFO - 'PWD': '/builds/slave/test', 15:21:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:24 INFO - 'RUST_BACKTRACE': 'full', 15:21:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:21:24 INFO - 'SHELL': '/bin/bash', 15:21:24 INFO - 'SHLVL': '1', 15:21:24 INFO - 'STYLO_FORCE_DISABLED': '1', 15:21:24 INFO - 'TERM': 'linux', 15:21:24 INFO - 'TMOUT': '86400', 15:21:24 INFO - 'USER': 'cltbld', 15:21:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056', 15:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:24 INFO - '_': '/tools/buildbot/bin/python'} 15:21:24 INFO - TEST-INFO | started process 25080 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_9mgYI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:25 INFO - PID 25080 | 15:21:25 INFO - PID 25080 | (/builds/slave/test/build/application/firefox/firefox:25130): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:21:25 INFO - PID 25080 | 15:21:35 INFO - PID 25080 | RSS: Main: 153964544 15:21:35 INFO - PID 25080 | 15:21:38 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35037/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:39 INFO - PID 25080 | RSS: Main: 159420416 15:21:39 INFO - PID 25080 | 15:21:42 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35037/tests/kraken/driver.html?testName=audio-dft) 15:21:42 INFO - PID 25080 | RSS: Main: 159547392 15:21:42 INFO - PID 25080 | 15:21:45 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35037/tests/kraken/driver.html?testName=audio-fft) 15:21:46 INFO - PID 25080 | RSS: Main: 156721152 15:21:46 INFO - PID 25080 | 15:21:48 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35037/tests/kraken/driver.html?testName=audio-oscillator) 15:21:48 INFO - PID 25080 | RSS: Main: 157425664 15:21:48 INFO - PID 25080 | 15:21:51 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:51 INFO - PID 25080 | RSS: Main: 157503488 15:21:51 INFO - PID 25080 | 15:21:54 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35037/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:55 INFO - PID 25080 | RSS: Main: 160370688 15:21:55 INFO - PID 25080 | 15:21:59 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35037/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:59 INFO - PID 25080 | RSS: Main: 159776768 15:21:59 INFO - PID 25080 | 15:22:02 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35037/tests/kraken/driver.html?testName=json-parse-financial) 15:22:03 INFO - PID 25080 | RSS: Main: 159719424 15:22:03 INFO - PID 25080 | 15:22:04 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:05 INFO - PID 25080 | RSS: Main: 159903744 15:22:05 INFO - PID 25080 | 15:22:07 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:22:07 INFO - PID 25080 | RSS: Main: 160026624 15:22:07 INFO - PID 25080 | 15:22:09 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:10 INFO - PID 25080 | RSS: Main: 156831744 15:22:10 INFO - PID 25080 | 15:22:13 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:13 INFO - PID 25080 | RSS: Main: 157622272 15:22:13 INFO - PID 25080 | 15:22:16 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:17 INFO - PID 25080 | RSS: Main: 157855744 15:22:17 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | Cycle 1(1): loaded http://localhost:35037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35037/tests/kraken/driver.html?testName=ai-astar) 15:22:19 INFO - PID 25080 | RSS: Main: 158810112 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | __start_tp_report 15:22:19 INFO - PID 25080 | _x_x_mozilla_page_load 15:22:19 INFO - PID 25080 | _x_x_mozilla_page_load_details 15:22:19 INFO - PID 25080 | |i|pagename|runs| 15:22:19 INFO - PID 25080 | |0;ai-astar;106;108;107;107;108;113;108;108;108;108 15:22:19 INFO - PID 25080 | |1;audio-beat-detection;117;117;116;120;116;121;116;115;122;118 15:22:19 INFO - PID 25080 | |2;audio-dft;162;164;164;163;162;163;163;168;179;166 15:22:19 INFO - PID 25080 | |3;audio-fft;74;74;73;74;73;74;74;74;75;75 15:22:19 INFO - PID 25080 | |4;audio-oscillator;80;79;79;79;79;80;79;79;79;80 15:22:19 INFO - PID 25080 | |5;imaging-gaussian-blur;112;114;114;114;115;114;115;114;110;114 15:22:19 INFO - PID 25080 | |6;imaging-darkroom;147;148;148;148;147;147;147;148;150;152 15:22:19 INFO - PID 25080 | |7;imaging-desaturate;97;94;95;94;93;94;94;94;94;96 15:22:19 INFO - PID 25080 | |8;json-parse-financial;52;53;53;53;53;52;51;54;55;52 15:22:19 INFO - PID 25080 | |9;json-stringify-tinderbox;37;38;37;38;37;37;38;38;37;37 15:22:19 INFO - PID 25080 | |10;stanford-crypto-aes;77;73;79;73;74;74;75;74;73;79 15:22:19 INFO - PID 25080 | |11;stanford-crypto-ccm;114;118;113;111;113;122;114;130;114;109 15:22:19 INFO - PID 25080 | |12;stanford-crypto-pbkdf2;169;170;173;173;173;172;174;177;170;173 15:22:19 INFO - PID 25080 | |13;stanford-crypto-sha256-iterative;70;70;70;66;65;67;65;67;66;68 15:22:19 INFO - PID 25080 | __end_tp_report 15:22:19 INFO - PID 25080 | __start_cc_report 15:22:19 INFO - PID 25080 | _x_x_mozilla_cycle_collect,725 15:22:19 INFO - PID 25080 | __end_cc_report 15:22:19 INFO - PID 25080 | __startTimestamp1505859739280__endTimestamp 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | ------- Summary: start ------- 15:22:19 INFO - PID 25080 | Number of tests: 14 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:1.85 (1.7%) stddev-sans-first:1.80 15:22:19 INFO - PID 25080 | Values: 106.0 108.0 107.0 107.0 108.0 113.0 108.0 108.0 108.0 108.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:117.50 stddev:2.39 (2.0%) stddev-sans-first:2.52 15:22:19 INFO - PID 25080 | Values: 117.0 117.0 116.0 120.0 116.0 121.0 116.0 115.0 122.0 118.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:5.13 (3.1%) stddev-sans-first:5.29 15:22:19 INFO - PID 25080 | Values: 162.0 164.0 164.0 163.0 162.0 163.0 163.0 168.0 179.0 166.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 15:22:19 INFO - PID 25080 | Values: 74.0 74.0 73.0 74.0 73.0 74.0 74.0 74.0 75.0 75.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 15:22:19 INFO - PID 25080 | Values: 80.0 79.0 79.0 79.0 79.0 80.0 79.0 79.0 79.0 80.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:1.48 15:22:19 INFO - PID 25080 | Values: 112.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 110.0 114.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.62 (1.1%) stddev-sans-first:1.66 15:22:19 INFO - PID 25080 | Values: 147.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 150.0 152.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.18 (1.3%) stddev-sans-first:0.83 15:22:19 INFO - PID 25080 | Values: 97.0 94.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 96.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.14 (2.1%) stddev-sans-first:1.17 15:22:19 INFO - PID 25080 | Values: 52.0 53.0 53.0 53.0 53.0 52.0 51.0 54.0 55.0 52.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.53 15:22:19 INFO - PID 25080 | Values: 37.0 38.0 37.0 38.0 37.0 37.0 38.0 38.0 37.0 37.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.38 (3.2%) stddev-sans-first:2.42 15:22:19 INFO - PID 25080 | Values: 77.0 73.0 79.0 73.0 74.0 74.0 75.0 74.0 73.0 79.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:114.00 stddev:6.14 (5.4%) stddev-sans-first:6.48 15:22:19 INFO - PID 25080 | Values: 114.0 118.0 113.0 111.0 113.0 122.0 114.0 130.0 114.0 109.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.00 stddev:2.32 (1.3%) stddev-sans-first:2.11 15:22:19 INFO - PID 25080 | Values: 169.0 170.0 173.0 173.0 173.0 172.0 174.0 177.0 170.0 173.0 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.01 (3.0%) stddev-sans-first:1.90 15:22:19 INFO - PID 25080 | Values: 70.0 70.0 70.0 66.0 65.0 67.0 65.0 67.0 66.0 68.0 15:22:19 INFO - PID 25080 | -------- Summary: end -------- 15:22:19 INFO - PID 25080 | 15:22:19 INFO - PID 25080 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:22:19 INFO - TEST-INFO | 25080: exit 0 15:22:19 INFO - TEST-OK | kraken | took 61236ms 15:22:19 INFO - SUITE-END | took 1170s 15:22:19 INFO - Completed test suite (00:19:30) 15:22:19 INFO - javascript benchmark 15:22:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8401.071947168377, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.546650735643, 3143.669914658962, 3151.8108913465185, 3170.857311420987, 3181.0297859152965, 6164.4143806338325, 6241.750329986795, 6250.187475628168, 6350.587211831228, 6362.936370636292, 6239.0, 6266.279377871546, 6267.153934218879, 6312.747490100391, 6324.9367506324925, 5764.682942438164, 5773.624714393562, 5791.044477661181, 5795.594308398393, 5819.82540523785, 5753.884922301551, 5815.912761308584, 5853.326867410238, 5870.794522191724, 5905.291365036202, 5833.648468443383, 5837.1536127261525, 5893.58744887858, 5905.527557795387, 5947.434993675615, 5569.972150139264, 5729.570282228808, 5733.226014488074, 5826.737796799154, 5944.227250457435, 5751.942480575182, 5798.594098413113, 5806.796762113348, 5832.416758324176, 5846.473817356416, 6201.441870231656, 6287.308396076428, 6288.591241569329, 6345.143405640272, 6359.777407790752, 6705.094812200388, 6724.966375168142, 6749.595024298558, 6749.7300107995625, 6803.455723542104, 6770.72917083316, 6788.456923446161, 6830.0, 6832.829179270509, 6842.110525631686, 6218.564700470969, 6223.782167624111, 6289.465395441439, 6311.274203466614, 6332.461740752042, 6791.694373753193, 6908.723651054002, 6913.308669133147, 6950.965245173843, 7037.0, 6573.112629795012, 6578.868422631521, 6580.76967306142, 6584.012398140318, 6585.9012114818315, 6628.53600247978, 6702.162229721285, 6711.865762684719, 6714.52998290115, 6722.260551339349, 6654.700538475683, 6664.86670266592, 6710.328967103348, 6716.597004179765, 6744.83137921546, 6721.1598550181225, 6750.8649827004165, 6755.020522024377, 6782.0, 6827.317268273133, 5266.4470230626, 5293.153095504701, 5331.626786124934, 5331.9869224847935, 5333.57331413486, 4540.523245059288, 4577.542245775396, 4622.583967442946, 4629.837955671535, 4714.481407045222, 5745.396733343023, 5749.080147176432, 5754.367019627837, 5758.2514273144225, 5776.480116789509, 6678.3989440950545, 6703.430208432241, 6763.951587503945, 6775.559588626724, 6810.9318906810295, 5638.85902852432, 5657.57568182388, 5698.287714035746, 5707.629004114802, 5747.6838773867, 5761.251037365199, 5782.0, 5782.855428614318, 5784.074548072288, 5791.710414479344, 6431.0, 6481.449076828428, 6482.935170648233, 6493.902591461132, 6554.63949482783, 6652.467802575879, 6731.326867313425, 6800.65996700163, 6823.147106611674, 6823.351781580742, 6464.482841372773, 6467.935320646733, 6550.017497375432, 6564.9671751640935, 6580.374864387875, 6516.348365163446, 6602.735890564323, 6603.108580341593, 6634.601923884582, 6706.329367063255, 6624.403803657694, 6686.765963191265, 6701.899471508029, 6706.926891697305, 6717.059611654275, 6468.611883287018, 6470.158879345655, 6486.383793539606, 6547.672616369067, 6600.768973085919, 6652.301508341748, 6660.6336651484635, 6663.13379260693, 6666.100076489612, 6666.266710661726, 6423.389777971085, 6441.645709486023, 6446.806595802133, 6530.967345163243, 6548.967255163694, 6394.520410969103, 6488.545801793829, 6568.770093046721, 6677.866442671217, 6694.899576506259, 6368.299487056513, 6379.330170332234, 6439.903401448888, 6458.063580780667, 6462.095306657166], "value": 6131.575196124097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.7552547523954, 889.8665200219968, 891.313688459886, 892.879461272728, 900.7612982559618, 38723.419148712754, 39644.60355396445, 42320.153596928045, 42440.57559424405, 42706.145877082476, 38511.61488385115, 38796.0, 38811.22377552447, 38817.805910970405, 38948.22103557927, 7113.679884405215, 7225.963870180642, 7237.276272372773, 7251.093613298338, 7833.060032796044, 7801.609919504031, 7916.247956444128, 7917.802054948644, 7922.524648521078, 7923.445358824884, 7918.247766462206, 7956.840863182733, 7961.084475285358, 7978.840423191533, 7992.720254791084, 7901.091374491921, 7932.801679957989, 7947.96026019872, 7956.085050219241, 7966.601669916481, 7841.607919603997, 7898.407619428566, 7907.051153861516, 7930.167332430127, 7937.920620793833, 37249.44125838114, 37484.625153748384, 37542.24915501675, 37570.62429375726, 37576.62423375758, 3519.771214871025, 3571.928561428757, 3575.570931488212, 3578.4632305154173, 3582.39099353108, 31522.054338369886, 31583.84208078968, 31594.526082108787, 31701.52447713286, 31719.682803171905, 5027.899442011139, 5109.054824857413, 5136.409312929024, 5147.510986456281, 5233.816816411445, 185499.0, 186030.0, 186554.0, 186725.0, 186778.06610966995, 41760.164796703895, 48793.0, 48972.26541601879, 48980.51019489831, 49078.0, 44210.33684494735, 49836.75081624569, 50487.24269135966, 50638.493615064115, 50654.49345506571, 16255.918720406322, 16279.186040697918, 16295.34818607266, 16392.918035409748, 16405.507834764976, 13305.40125694346, 13327.200367977952, 13327.800082998763, 13330.933345333211, 13331.866681333062, 13852.584422467342, 13891.86108138926, 13931.164130152223, 13976.811970982377, 14048.016638835388, 5712.714364281769, 5730.19777231188, 5738.598298119092, 5806.677329068407, 5825.650460972355, 1014.5688082564881, 1028.290479569095, 1046.612753281291, 1052.6894566103017, 1059.2796898109204, 23234.767652323597, 23437.531249375257, 23445.296641100795, 23484.882575587013, 23720.288391348287, 1115.7043383503378, 1127.1490025031048, 1135.7558125003163, 1135.926164799302, 1149.68383694483, 12230.449629766681, 12431.191972521758, 12456.252624842538, 12556.874431255754, 12661.430235639235, 211127.0, 211205.0, 211214.0, 211517.0, 212054.0, 52763.73618131885, 52931.735341323816, 53011.46988530143, 53089.0, 53155.73422132865, 1423.686788906439, 1478.5564330700747, 1492.6492274315526, 1498.243387089513, 1507.8039854818803, 23265.651015234445, 23266.0, 23266.651000234673, 23330.300090997298, 23518.76481235166, 37702.057448564, 37718.62281377261, 37808.810955945046, 37815.24369512539, 37887.62112378951, 176681.0, 176723.0, 177792.0, 178849.0, 179612.0, 30930.381392372477, 31415.52876706897, 33589.83205084057, 33610.327793444485, 33661.49507757337, 42928.35607465953, 42992.57007430011, 43138.13723725571, 43201.13597728091, 43231.78384108059, 31668.841655791573, 31756.364872701954, 31786.841065794524, 31841.522377164823, 32627.0, 31753.5236971441, 31773.841130794197, 31869.840650797527, 31963.680363196072, 32126.196845078124, 35612.10969725777, 35632.46551301784, 35805.283894322485, 35992.460113098845, 36026.0, 30950.690493094782, 31015.224619384695, 31216.0, 31301.0, 31702.207444814063, 23535.646965295193, 23616.17343392973, 23700.644490332314, 23819.404514887265, 24142.275731728078], "value": 17074.744376839397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.417619851553, 571.1404336473606, 573.8020382967876, 578.9392113828048, 580.1848402993793, 21975.560488790234, 22751.772482275173, 22789.0, 22815.657765133536, 22829.657555136644, 23302.41743956402, 24241.27276181713, 24271.27186184413, 24677.50644987099, 24794.380140496498, 6422.389872962073, 6624.304448032959, 6649.035889795977, 6649.734010639569, 6684.465242780566, 6523.93476065238, 6673.165854268216, 6683.598984060972, 6691.0, 6699.397054265115, 6301.117843501914, 6572.0141978703095, 6581.440577550914, 6583.9012414813815, 6617.205935287772, 6574.3754343337305, 6637.1703537057865, 6637.601743895358, 6642.169728783902, 6646.0363247329105, 5980.073088671263, 6060.090986352083, 6104.389561043905, 6166.445019948182, 6185.103160041769, 28215.43569128606, 28755.0, 28887.855560722062, 28944.565831512544, 28946.855265723538, 2037.0934933954395, 2064.9277275295444, 2065.401033700225, 2065.7211276477633, 2070.896455177235, 17516.38692645751, 19619.313324033734, 19750.70373944392, 19959.600807983905, 19998.300059497848, 2364.7635236476217, 2433.209207007712, 2440.3533063737946, 2443.2059580636364, 2448.669429626995, 118060.0, 124565.0, 132408.33795831056, 141065.294673527, 141673.0, 14526.631168330308, 14533.0, 14644.121352718657, 14865.851341486446, 14941.103533788008, 22315.33054008382, 22914.0, 22917.770822291564, 22928.19751308696, 23068.53862922732, 10130.493475326204, 10355.0, 10372.0, 10457.372557646566, 10475.319104258198, 9597.23222142227, 9627.277954153327, 9698.36960597559, 9700.27247956406, 9831.311808173503, 8779.69271075522, 8866.024737278894, 9173.862392063991, 9236.907630923739, 9240.445573265491, 2630.355562887105, 2663.9866800665873, 2758.2898602866353, 2819.9414427468064, 2838.68774434812, 960.9231261499064, 970.9514524273758, 981.283662926068, 981.9361741486781, 996.7458298133929, 18283.72574411385, 18349.17428715711, 18426.327599102468, 18715.438536843918, 18776.248950042118, 1018.6231094494937, 1025.43601019439, 1035.3735989726258, 1050.9264351495474, 1059.597353005853, 10278.743031424274, 10404.58381664725, 10532.315399499008, 10609.946950265354, 10627.256092073636, 490718.0, 510897.0, 512280.0, 512726.0, 513147.0, 107885.46057269664, 108156.45921770498, 108803.45598271958, 110028.0, 110870.0, 1049.5959055763585, 1091.476091476096, 1106.1758989552834, 1137.4995002199005, 1160.6227975907864, 19228.0, 19400.611987759883, 19584.51038723986, 19623.411297661092, 19796.406107816787, 53145.202821956926, 53877.0, 53968.0, 54503.45496544984, 54823.0, 66657.66671166613, 66807.0, 67424.6628766853, 67454.66272668606, 67693.66153169202, 13902.0, 14249.501267456004, 14265.928670356581, 14323.069000514934, 14351.282435877956, 21919.12323507042, 22073.11707531745, 22132.778672213073, 22133.225337113123, 22321.77678223197, 17483.300667973137, 17719.202635881673, 17881.46355609334, 17899.37352192667, 17982.0, 15893.364265429253, 16155.919220403823, 16211.918940405223, 16461.753073703665, 16472.917635412225, 17843.464696059138, 18401.171947262137, 18679.533011674815, 18812.717809233145, 18826.24695012184, 13882.0, 13945.372458239606, 14062.859371406155, 14087.859121408655, 14125.223112728898, 17569.82430175733, 17993.910030449762, 18030.90984545069, 18141.0, 18141.092945352415], "value": 11819.525605539795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.3004437692398, 1402.1587047771338, 1418.7729963205888, 1419.4322271091569, 1422.3741553716363, 14277.143371397711, 14904.627384315383, 14913.776293355595, 14916.105033697986, 14946.177960212184, 14610.780838287434, 14633.634159146026, 14673.706525869502, 14748.188849613267, 14751.0, 2690.3812123211674, 2719.2386131883054, 2742.520058989679, 2752.8073034887566, 2772.88908443662, 2704.9323766905786, 2709.336212627909, 2727.5772255300462, 2740.9177724668293, 2742.0676969830256, 2708.647875776156, 2801.243664210662, 2808.606795048695, 2809.0730059080556, 2816.380396312808, 2741.6984131745494, 2755.1596762987283, 2768.9723102768917, 2780.694123646397, 2780.708025657297, 2690.9461810763673, 2702.6216329713857, 2715.253305341027, 2717.062613398394, 2805.5651374037056, 14388.208648524327, 14510.0, 14510.782338264935, 14518.854811451962, 14541.200233987127, 7865.134835168127, 8147.185281471865, 8152.144024877421, 8154.8776768348525, 8156.673733050671, 5444.897635924431, 5551.9722401387735, 5599.692016939067, 5673.432656734293, 5691.317041954951, 1876.6152938647544, 1895.75355203824, 1914.9904250478658, 1945.5525229197222, 1945.6692362298443, 24132.51734965291, 24180.637290440656, 24256.757432425802, 24271.514569708685, 24317.513649727083, 6140.846478838065, 6485.156929599122, 6581.802545923534, 6688.899666505006, 6711.765088221889, 16731.163441828103, 16771.748423773653, 18504.629907402046, 19323.4202973911, 19454.416367509, 7999.320057795153, 8223.17768223173, 8224.0, 8227.465214761141, 8229.094799572042, 7156.320149585781, 7209.0, 7265.491415600963, 7310.817229569197, 7333.0, 5424.186372044225, 5590.664560126405, 5664.971675141598, 5672.177534257509, 5682.40334764852, 1726.2318268370454, 1751.6584266067994, 1772.0696634267113, 1775.0858307971405, 1827.5979284557377, 870.1559487297311, 885.9734207973771, 901.5402144906145, 903.5301643145527, 907.6278725722422, 7150.678219480136, 7258.3104605062435, 7264.237255088246, 7294.927050729425, 7295.452841036943, 686.1217641418991, 720.1969803668871, 720.8882623193414, 722.9746958856415, 731.5208538407352, 4810.5327874997765, 5237.973810130925, 5253.343332083489, 5375.377175628956, 5456.372517160498, 19527.707084393747, 20017.899910500353, 20535.4866128348, 20538.486537836674, 20836.37490875276, 19443.611127777363, 19569.706454403196, 20195.293164739163, 20335.491612709506, 20383.694244586342, 10670.253082284165, 10744.946275268574, 10911.672649820519, 10912.745034321155, 10932.0, 7850.725224617111, 8003.3597312213715, 8066.556339401154, 8087.433879628369, 8098.83802323962, 16858.241379137722, 16970.151492425575, 17258.654826903643, 17393.739093913347, 17441.56396090108, 17120.828791711923, 17478.91260543689, 17617.29530818804, 17623.325784050496, 17794.733079004083, 11701.941490292495, 11764.0, 11765.647030588754, 11768.70578235551, 11774.116941229271, 12788.104832661624, 13089.803652945404, 13137.868621313664, 13205.867941320465, 13218.933905330412, 10918.399488027917, 10978.0, 11229.831552526883, 11281.32312061279, 11304.886951130384, 10689.198310126616, 10795.136389088697, 10888.455577221266, 10935.83596246041, 10936.50785714629, 9407.623695052122, 9427.104425079606, 9447.669331573363, 9474.905250947679, 9539.713808585753, 7040.119985001875, 7106.893396598952, 7116.964415177891, 7219.530730502501, 7244.710211591688, 7278.745243916437, 7400.777976660709, 7455.478116531791, 7476.4392670551015, 7490.4007679386605], "value": 6551.483129894629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.2022552196001, 500.9547900701834, 520.5211205690764, 523.7381309345327, 526.8656492594388, 6227.065940108986, 6233.0, 6275.7489700411925, 6306.180196574451, 6314.811020434674, 6095.146679464868, 6244.687765611724, 6291.20700600329, 6316.968415157918, 6328.430441260286, 5193.818216362428, 5218.295530103444, 5220.582353411718, 5221.660592061523, 5231.346081739783, 4737.526247375269, 5100.183970564711, 5171.586273098162, 5195.740212989354, 5251.715503755879, 4845.940475298002, 4868.148074087038, 4889.504004636684, 4913.582345500637, 4914.913064977749, 4881.926771098437, 4894.877628059309, 4903.141950158708, 4924.409070911478, 4935.580475659555, 4329.0, 4407.1185762847235, 4455.242608756519, 4478.08199319142, 4507.639388848885, 5926.555508336892, 6005.279366476051, 6071.301800292978, 6082.300535438437, 6106.0, 5670.206171136044, 5678.574106941955, 5683.5737319700775, 5698.914516282259, 5699.629524080921, 6482.448991835699, 6505.6421896795655, 6534.477241820643, 6559.311272316386, 6562.77030303937, 4617.145828021827, 4859.805607775685, 4875.951240487585, 4889.657723959324, 4896.632752543574, 6560.179977502812, 6692.096566963495, 6717.966410167918, 6785.966070169667, 6852.486063545254, 4930.556249937523, 4938.530839570235, 4981.2030075187795, 4995.750212489361, 5013.373328333958, 5011.34852469184, 5015.724135172601, 5024.61822998671, 5058.949410505921, 5081.822136225288, 5562.276904002454, 5592.832215033555, 5602.355729091207, 5610.72765529961, 5664.915026274609, 6482.513811464159, 6486.610803351814, 6542.182227221598, 6546.18172728409, 6576.86846263072, 1727.153694689593, 1732.7400889866622, 1745.6945034619146, 1750.2298988445043, 1768.2484943898792, 1156.7166044319197, 1207.9396030198454, 1226.51552636708, 1230.267990545624, 1241.6088931986396, 5565.16522521625, 5589.4070189995655, 5641.689707066151, 5651.208830763697, 5657.2928383952, 6538.117354157128, 6584.8024559263295, 6631.436327912182, 6658.234303055211, 6726.932730672728, 5521.144222645416, 5528.889422211533, 5529.30883639545, 5587.357453892773, 5612.7754889803955, 3502.0, 3518.296340731864, 3520.559930008749, 3530.5763308403157, 3538.6461353864925, 6309.211348581427, 6348.968255158787, 6370.840728981812, 6396.488280937514, 6406.35936406365, 6754.358335958076, 6786.117804685359, 6809.829754256183, 6849.04113424121, 6885.655717214119, 5898.1661919752505, 6308.243010838729, 6329.873402531924, 6337.162222955476, 6459.677016149174, 6493.837654058498, 6558.573692709959, 6567.573107747981, 6587.4848784780725, 6593.967030164818, 6357.618542887441, 6421.614703117828, 6448.806535803933, 6474.967625161844, 6575.835604109936, 6220.4759833841, 6289.654069026247, 6317.0, 6374.107624932421, 6420.6468644225015, 4921.458639549575, 4946.752662366795, 4970.378702662168, 4974.253861920741, 5006.69959802413, 6341.143945567289, 6615.0, 6660.334916270932, 6668.633225172468, 6758.290379510081, 6224.346443623354, 6428.517861160338, 6445.581037232565, 6479.773207937699, 6561.278259391559, 6355.5551111421755, 6455.644939528371, 6486.416222539994, 6487.632014314647, 6515.055316978916, 6304.0, 6310.842228944313, 6319.462845657987, 6349.6507692077375, 6423.903641445476, 6376.681165941777, 6466.256380516113, 6491.604305074432, 6502.73989040452, 6518.73925042993, 6290.968545157245, 6299.622022678654, 6306.180196574416, 6331.6517591531065, 6334.398232167937], "value": 5005.144688785695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.3219636977717, 914.9817003659927, 938.3853575907779, 944.7732544189397, 949.672363034753, 19064.71402928957, 19825.0, 19976.001199939998, 20031.399058028263, 20032.399028029147, 17363.392206391836, 17524.649507009854, 17788.64422711548, 18245.0, 18476.076196190203, 957.5978089202534, 975.3172779054655, 977.4721650308825, 977.5454413697629, 978.4618459847092, 977.9364341317792, 992.4987881120024, 994.4530508220486, 996.8405055191171, 997.6209040564612, 1047.7223535763028, 1061.2147011211725, 1061.7345663584103, 1062.0388548363744, 1062.2139616683676, 994.6767300627325, 1048.8951104889527, 1051.8527406163143, 1054.5518154784186, 1055.978880422395, 744.3598505285504, 746.1233051164913, 746.7946314763429, 751.0649241694126, 751.3087959077661, 18133.36533221344, 18228.63542729138, 18269.45191644253, 18275.36036238725, 18282.817171828377, 21156.682649760267, 21341.253056143116, 22015.889920550453, 22222.444438888997, 22241.0, 16136.596585085466, 17242.0, 17290.7406388903, 17335.566610834703, 17532.91233543837, 3695.1685870678884, 3715.442683597482, 3728.105254738843, 3729.869454569104, 3732.365497865342, 120582.0, 127085.36457317747, 127635.36182319121, 128415.35792320978, 128805.0, 15404.152771597446, 15658.373665053497, 15681.294341754648, 15752.212389380486, 15838.76241856373, 31031.379372412877, 31501.36997260042, 31558.211044724067, 31606.683933160835, 31624.841875790473, 8305.584720763938, 8391.664333426717, 8434.030086540004, 8448.07071222165, 8469.957650211833, 3900.3369427197445, 3975.840966361371, 3991.022199561126, 3999.480067591253, 4012.879613611596, 5246.108161612535, 5316.9202461963105, 5318.946810531846, 5396.433374495621, 5407.540359069523, 976.9804603908024, 996.6760802739138, 1000.0999100809184, 1006.9194464442827, 1008.3395376028712, 621.1583304622262, 633.2749002392327, 636.5734957578434, 642.6754488983128, 651.0007139041643, 10820.458977051116, 11258.380789056517, 11362.886371136183, 11485.770284594428, 11604.593839215588, 609.4697613076563, 613.5980932489226, 615.2125279642065, 619.4765423217374, 640.5292110298926, 5296.788128474818, 5322.600804939645, 5348.224507446398, 5362.570994320445, 5446.128619420953, 123414.0, 123651.38174309251, 124299.0, 125305.37347313204, 129031.0, 107494.0, 108429.0, 111027.0, 112628.43685781682, 115156.42421788005, 91727.54136229276, 93402.0, 95284.0, 95858.0, 96467.0, 9803.803923921625, 9944.502774861083, 9996.050375214343, 10070.647527336509, 10083.949580252052, 42059.369109463994, 42693.78653106715, 44707.0, 44786.3282050776, 45719.77140114278, 55664.0, 56132.71933640305, 58299.4170058294, 58799.41200587939, 58814.705926470095, 14615.561533154023, 14668.77996830027, 14678.559643210721, 14761.483348082766, 14804.703905922037, 16566.420175293806, 16633.916830416256, 16693.749593756347, 16800.32798688088, 16895.662086758442, 15092.698146036799, 15763.290651920463, 15925.920370398075, 15937.12345820991, 15988.760168597713, 16029.198540072717, 16064.196790160211, 16166.110863902599, 16274.755878661592, 16404.589885252964, 14089.647758805702, 14150.716985660023, 14186.0, 14286.357113930106, 14392.06451580644, 10008.0, 10256.48717564104, 10321.74195645115, 10351.844722329322, 10405.843912341472, 10447.94776026115, 10583.523741431809, 10614.89385106139, 10821.621243256448, 10842.186835987175], "value": 8663.62462241979, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 107.0, 107.0, 108.0, 113.0, 108.0, 108.0, 108.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 120.0, 116.0, 121.0, 116.0, 115.0, 122.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 163.0, 162.0, 163.0, 163.0, 168.0, 179.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 74.0, 73.0, 74.0, 74.0, 74.0, 75.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 110.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 150.0, 152.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 51.0, 54.0, 55.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 38.0, 38.0, 37.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 79.0, 73.0, 74.0, 74.0, 75.0, 74.0, 73.0, 79.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 113.0, 111.0, 113.0, 122.0, 114.0, 130.0, 114.0, 109.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 173.0, 173.0, 173.0, 172.0, 174.0, 177.0, 170.0, 173.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 66.0, 65.0, 67.0, 65.0, 67.0, 66.0, 68.0], "value": 67.4, "unit": "score"}]}]} 15:22:19 INFO - Return code: 0 15:22:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:22:20 INFO - # TBPL SUCCESS # 15:22:20 INFO - Running post-action listener: _package_coverage_data 15:22:20 INFO - Running post-action listener: _resource_record_post_action 15:22:20 INFO - [mozharness: 2017-09-19 22:22:20.060936Z] Finished run-tests step (success) 15:22:20 INFO - Running post-run listener: _resource_record_post_run 15:22:20 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 338042880; Read time: 256; Write time: 285232 15:22:20 INFO - TinderboxPrint: CPU usage
13.1% 15:22:20 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 256 15:22:20 INFO - TinderboxPrint: I/O write bytes / time
338,042,880 / 285,232 15:22:20 INFO - TinderboxPrint: CPU idle
8,235.4 (86.9%) 15:22:20 INFO - TinderboxPrint: CPU user
1,190.9 (12.6%) 15:22:20 INFO - TinderboxPrint: Swap in / out
0 / 0 15:22:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10571776; Read time: 0; Write time: 1824 15:22:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:22:20 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 327471104; Read time: 248; Write time: 283408 15:22:20 INFO - Running post-run listener: _upload_blobber_files 15:22:20 INFO - Blob upload gear active. 15:22:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:20 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 15:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:21 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:22:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:22:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:22 INFO - (blobuploader) - INFO - Done attempting. 15:22:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:22:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:23 INFO - (blobuploader) - INFO - Done attempting. 15:22:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:22:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:24 INFO - (blobuploader) - INFO - Done attempting. 15:22:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:30 INFO - (blobuploader) - INFO - Done attempting. 15:22:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:30 INFO - Return code: 0 15:22:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3ef2d0ec1c6609c782f5d1895ed876a87e98bfa4070e80a233b81c256b18197c4385ab56a10f11ae8e0dda2da62d7c6643460a0e660df1a1deda7e5ab4be54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5cd7a42911f8634d27bf221ac0809f69caa129001271f9c5d14429aacf0d289273da82545b2bdcab882ab591b90ab11856d138d8f7451c42de9fd9853e6f7b7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95788483c95fe9d718b8a389e51e526492c5650ee1c328ae2414eb8a743f9d9aa8e7f1230685d0f71865c851bd43cdf3049355f072354ddd99969b2700e98577", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e8881f617342206b3e80265e33ef41146d788b7ca027a58aa1ea79014e2d8b3f6015e5baf1cf284771d1dd0b676986a1dca3d881a95044e61a7fdde14ca5d74"} 15:22:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:30 INFO - Contents: 15:22:30 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3ef2d0ec1c6609c782f5d1895ed876a87e98bfa4070e80a233b81c256b18197c4385ab56a10f11ae8e0dda2da62d7c6643460a0e660df1a1deda7e5ab4be54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5cd7a42911f8634d27bf221ac0809f69caa129001271f9c5d14429aacf0d289273da82545b2bdcab882ab591b90ab11856d138d8f7451c42de9fd9853e6f7b7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95788483c95fe9d718b8a389e51e526492c5650ee1c328ae2414eb8a743f9d9aa8e7f1230685d0f71865c851bd43cdf3049355f072354ddd99969b2700e98577", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e8881f617342206b3e80265e33ef41146d788b7ca027a58aa1ea79014e2d8b3f6015e5baf1cf284771d1dd0b676986a1dca3d881a95044e61a7fdde14ca5d74"} 15:22:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:30 INFO - Copying logs to upload dir... 15:22:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.682418 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-19 15:22:30.865869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:30.872793) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3ef2d0ec1c6609c782f5d1895ed876a87e98bfa4070e80a233b81c256b18197c4385ab56a10f11ae8e0dda2da62d7c6643460a0e660df1a1deda7e5ab4be54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5cd7a42911f8634d27bf221ac0809f69caa129001271f9c5d14429aacf0d289273da82545b2bdcab882ab591b90ab11856d138d8f7451c42de9fd9853e6f7b7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95788483c95fe9d718b8a389e51e526492c5650ee1c328ae2414eb8a743f9d9aa8e7f1230685d0f71865c851bd43cdf3049355f072354ddd99969b2700e98577", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e8881f617342206b3e80265e33ef41146d788b7ca027a58aa1ea79014e2d8b3f6015e5baf1cf284771d1dd0b676986a1dca3d881a95044e61a7fdde14ca5d74"} build_url:https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e3ef2d0ec1c6609c782f5d1895ed876a87e98bfa4070e80a233b81c256b18197c4385ab56a10f11ae8e0dda2da62d7c6643460a0e660df1a1deda7e5ab4be54", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e5cd7a42911f8634d27bf221ac0809f69caa129001271f9c5d14429aacf0d289273da82545b2bdcab882ab591b90ab11856d138d8f7451c42de9fd9853e6f7b7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95788483c95fe9d718b8a389e51e526492c5650ee1c328ae2414eb8a743f9d9aa8e7f1230685d0f71865c851bd43cdf3049355f072354ddd99969b2700e98577", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e8881f617342206b3e80265e33ef41146d788b7ca027a58aa1ea79014e2d8b3f6015e5baf1cf284771d1dd0b676986a1dca3d881a95044e61a7fdde14ca5d74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:30.900601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:30.900916) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505848291.41296-557265056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:30.983183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 15:22:30.985530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 15:22:30.985842) ========= ========= Total master_lag: 0.22 =========