builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1505858484.93 results: success (0) revision: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:24.925809) ========= 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:24.926626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:24.926906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:25.015875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:25.016135) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 15:01:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-09-19 15:01:25 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.240463 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:25.348468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:25.348779) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017265 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:25.410556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:25.410926) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 15:01:25,482 truncating revision to first 12 chars 2017-09-19 15:01:25,482 Setting DEBUG logging. 2017-09-19 15:01:25,482 attempt 1/10 2017-09-19 15:01:25,482 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:26,130 unpacking tar archive at: mozilla-central-c0d1f9eb2a40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.939581 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:26.385259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:26.388584) ========= script_repo_revision: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:26.388944) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:26.389247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 15:01:26.402542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-09-19 15:01:26.402837) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:26 INFO - MultiFileLogger online at 20170919 15:01:26 in /builds/slave/test 15:01:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:01:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:26 INFO - {'append_to_log': False, 15:01:26 INFO - 'base_work_dir': '/builds/slave/test', 15:01:26 INFO - 'blob_upload_branch': 'Firefox', 15:01:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:26 INFO - 'branch': 'Firefox', 15:01:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:26 INFO - 'code_coverage': False, 15:01:26 INFO - 'config_files': ('talos/linux_config.py',), 15:01:26 INFO - 'default_actions': ('clobber', 15:01:26 INFO - 'read-buildbot-config', 15:01:26 INFO - 'download-and-extract', 15:01:26 INFO - 'populate-webroot', 15:01:26 INFO - 'create-virtualenv', 15:01:26 INFO - 'install', 15:01:26 INFO - 'setup-mitmproxy', 15:01:26 INFO - 'run-tests'), 15:01:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:26 INFO - 'disable_ccov_upload': False, 15:01:26 INFO - 'disable_stylo': False, 15:01:26 INFO - 'download_minidump_stackwalk': True, 15:01:26 INFO - 'download_symbols': 'ondemand', 15:01:26 INFO - 'enable_stylo': False, 15:01:26 INFO - 'enable_webrender': False, 15:01:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:01:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:26 INFO - 'gecko_profile': False, 15:01:26 INFO - 'gecko_profile_interval': 0, 15:01:26 INFO - 'installer_path': 'installer.exe', 15:01:26 INFO - 'log_level': 'info', 15:01:26 INFO - 'log_name': 'talos', 15:01:26 INFO - 'log_to_console': True, 15:01:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:26 INFO - 'opt_config_files': (), 15:01:26 INFO - 'pip_index': False, 15:01:26 INFO - 'suite': 'dromaeojs-e10s', 15:01:26 INFO - 'system_bits': '32', 15:01:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:26 INFO - 'title': 'talos-linux64-ix-029', 15:01:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:26 INFO - 'use_talos_json': True, 15:01:26 INFO - 'verify': 'False', 15:01:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:26 INFO - 'work_dir': 'build'} 15:01:26 INFO - [mozharness: 2017-09-19 22:01:26.699381Z] Running clobber step. 15:01:26 INFO - Running pre-action listener: _resource_record_pre_action 15:01:26 INFO - Running main action method: clobber 15:01:26 INFO - rmtree: /builds/slave/test/build 15:01:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:27 INFO - Running post-action listener: _resource_record_post_action 15:01:27 INFO - [mozharness: 2017-09-19 22:01:27.642416Z] Finished clobber step (success) 15:01:27 INFO - [mozharness: 2017-09-19 22:01:27.642513Z] Running read-buildbot-config step. 15:01:27 INFO - Running pre-action listener: _resource_record_pre_action 15:01:27 INFO - Running main action method: read_buildbot_config 15:01:27 INFO - Using buildbot properties: 15:01:27 INFO - { 15:01:27 INFO - "project": "", 15:01:27 INFO - "product": "firefox", 15:01:27 INFO - "who": "kwierso@gmail.com", 15:01:27 INFO - "installer_path": "public/build/target.tar.bz2", 15:01:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:01:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:01:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:01:27 INFO - "stage_platform": "linux64-qr", 15:01:27 INFO - "basedir": "/builds/slave/test", 15:01:27 INFO - "buildnumber": 77, 15:01:27 INFO - "platform": "ubuntu64_hw_qr", 15:01:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:01:27 INFO - "slavebuilddir": "test", 15:01:27 INFO - "taskId": "Jq9IJLkHSWOBgY8NciVH7Q", 15:01:27 INFO - "branch": "mozilla-central", 15:01:27 INFO - "script_repo_revision": "production", 15:01:27 INFO - "revision": "c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f", 15:01:27 INFO - "slavename": "talos-linux64-ix-029", 15:01:27 INFO - "repo_path": "mozilla-central" 15:01:27 INFO - } 15:01:27 INFO - Finding installer, test and symbols from parent task. 15:01:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jq9IJLkHSWOBgY8NciVH7Q'}, attempt #1 15:01:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jq9IJLkHSWOBgY8NciVH7Q'}, attempt #1 15:01:28 INFO - Task dependencies: AyerD6BRQGKrCIFu0VWbgg 15:01:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg'}, attempt #1 15:01:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:01:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.test_packages.json 15:01:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip 15:01:29 INFO - Running post-action listener: _resource_record_post_action 15:01:29 INFO - [mozharness: 2017-09-19 22:01:29.081481Z] Finished read-buildbot-config step (success) 15:01:29 INFO - [mozharness: 2017-09-19 22:01:29.081699Z] Running download-and-extract step. 15:01:29 INFO - Running pre-action listener: _resource_record_pre_action 15:01:29 INFO - Running main action method: download_and_extract 15:01:29 INFO - mkdir: /builds/slave/test/build/tests 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - trying https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.test_packages.json 15:01:29 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:29 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:29 INFO - Downloaded 989 bytes. 15:01:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:01:29 INFO - Using the following test package requirements: 15:01:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:01:29 INFO - u'common': [u'target.common.tests.zip'], 15:01:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:01:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:01:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:01:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:01:29 INFO - u'mozbase': [u'target.common.tests.zip'], 15:01:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:01:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:01:29 INFO - u'web-platform': [u'target.common.tests.zip', 15:01:29 INFO - u'target.web-platform.tests.tar.gz'], 15:01:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:01:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:01:29 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:29 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:29 INFO - Fetch https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.common.tests.zip into memory 15:01:31 INFO - Content-Length response header: 54731597 15:01:31 INFO - Bytes received: 54731597 15:01:43 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:01:43 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:01:43 INFO - Fetch https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.talos.tests.zip into memory 15:01:43 INFO - Content-Length response header: 14508904 15:01:43 INFO - Bytes received: 14508904 15:01:44 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:44 INFO - trying https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:01:44 INFO - Downloading https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:01:44 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:01:46 INFO - Downloaded 61759510 bytes. 15:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:01:46 INFO - mkdir: /builds/slave/test/properties 15:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:46 INFO - Contents: 15:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 15:01:46 INFO - Running post-action listener: _resource_record_post_action 15:01:46 INFO - Running post-action listener: find_tests_for_verification 15:01:46 INFO - Running post-action listener: set_extra_try_arguments 15:01:46 INFO - [mozharness: 2017-09-19 22:01:46.355879Z] Finished download-and-extract step (success) 15:01:46 INFO - [mozharness: 2017-09-19 22:01:46.355975Z] Running populate-webroot step. 15:01:46 INFO - Running pre-action listener: _resource_record_pre_action 15:01:46 INFO - Running main action method: populate_webroot 15:01:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['tresize', 15:01:46 INFO - 'tcanvasmark']}, 15:01:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['dromaeo_css', 15:01:46 INFO - 'kraken']}, 15:01:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'tests': ['damp', 'tps']}, 15:01:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['damp', 'tps']}, 15:01:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['dromaeo_dom']}, 15:01:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:01:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['basic_compositor_video', 15:01:46 INFO - 'glvideo']}, 15:01:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:01:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['ts_paint_webext', 15:01:46 INFO - 'tp5o_webext']}, 15:01:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_many_windows', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['a11yr', 15:01:46 INFO - 'ts_paint', 15:01:46 INFO - 'tpaint', 15:01:46 INFO - 'sessionrestore', 15:01:46 INFO - 'sessionrestore_many_windows', 15:01:46 INFO - 'sessionrestore_no_auto_restore', 15:01:46 INFO - 'tabpaint']}, 15:01:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:01:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:01:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['perf_reftest_singletons']}, 15:01:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['bloom_basic']}, 15:01:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:46 INFO - 'tsvgr_opacity', 15:01:46 INFO - 'tart', 15:01:46 INFO - 'tscrollx', 15:01:46 INFO - 'tsvg_static']}, 15:01:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['tsvgx', 15:01:46 INFO - 'tsvgr_opacity', 15:01:46 INFO - 'tart', 15:01:46 INFO - 'tscrollx', 15:01:46 INFO - 'tsvg_static']}, 15:01:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-stylo'], 15:01:46 INFO - 'tests': ['tp5o']}, 15:01:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:01:46 INFO - 'talos_options': ['--mitmproxy', 15:01:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:01:46 INFO - '--firstNonBlankPaint'], 15:01:46 INFO - 'tests': ['tp6_google', 15:01:46 INFO - 'tp6_youtube', 15:01:46 INFO - 'tp6_amazon', 15:01:46 INFO - 'tp6_facebook']}, 15:01:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:01:46 INFO - 'talos_options': ['--disable-stylo', 15:01:46 INFO - '--mitmproxy', 15:01:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:01:46 INFO - '--firstNonBlankPaint'], 15:01:46 INFO - 'tests': ['tp6_google', 15:01:46 INFO - 'tp6_youtube', 15:01:46 INFO - 'tp6_amazon', 15:01:46 INFO - 'tp6_facebook']}, 15:01:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:01:46 INFO - 'talos_options': ['--stylo-threads=1', 15:01:46 INFO - '--mitmproxy', 15:01:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:01:46 INFO - '--firstNonBlankPaint'], 15:01:46 INFO - 'tests': ['tp6_google', 15:01:46 INFO - 'tp6_youtube', 15:01:46 INFO - 'tp6_amazon', 15:01:46 INFO - 'tp6_facebook']}, 15:01:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--xperf_path', 15:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:46 INFO - 'tests': ['tp5n']}, 15:01:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:01:46 INFO - 'talos_options': ['--disable-stylo', 15:01:46 INFO - '--xperf_path', 15:01:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:46 INFO - 'tests': ['tp5n']}}} 15:01:46 INFO - Running post-action listener: _resource_record_post_action 15:01:46 INFO - [mozharness: 2017-09-19 22:01:46.370765Z] Finished populate-webroot step (success) 15:01:46 INFO - [mozharness: 2017-09-19 22:01:46.370854Z] Running create-virtualenv step. 15:01:46 INFO - Running pre-action listener: _resource_record_pre_action 15:01:46 INFO - Running main action method: create_virtualenv 15:01:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:01:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:01:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:01:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:52 INFO - Installing pip...............done. 15:01:52 INFO - Return code: 0 15:01:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:52 INFO - Reading from file tmpfile_stdout 15:01:52 INFO - Output received: 15:01:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:01:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:01:52 INFO - Using env: {'DISPLAY': ':0', 15:01:52 INFO - 'HOME': '/home/cltbld', 15:01:52 INFO - 'LANG': 'en_US.UTF-8', 15:01:52 INFO - 'LANGUAGE': 'en_US:en', 15:01:52 INFO - 'LOGNAME': 'cltbld', 15:01:52 INFO - 'MAIL': '/var/mail/cltbld', 15:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:52 INFO - 'MOZ_NO_REMOTE': '1', 15:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:52 INFO - 'NO_EM_RESTART': '1', 15:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:52 INFO - 'PWD': '/builds/slave/test', 15:01:52 INFO - 'SHELL': '/bin/bash', 15:01:52 INFO - 'SHLVL': '1', 15:01:52 INFO - 'TERM': 'linux', 15:01:52 INFO - 'TMOUT': '86400', 15:01:52 INFO - 'USER': 'cltbld', 15:01:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:52 INFO - '_': '/tools/buildbot/bin/python'} 15:01:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:01:53 INFO - Downloading/unpacking pip>=1.5 15:01:53 INFO - Running setup.py egg_info for package pip 15:01:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:01:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:01:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:01:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:01:53 INFO - Installing collected packages: pip 15:01:53 INFO - Found existing installation: pip 1.1 15:01:53 INFO - Uninstalling pip: 15:01:53 INFO - Successfully uninstalled pip 15:01:53 INFO - Running setup.py install for pip 15:01:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:01:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:01:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:01:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:01:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:01:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:01:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:01:53 INFO - Successfully installed pip 15:01:53 INFO - Cleaning up... 15:01:53 INFO - Return code: 0 15:01:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:53 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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:01:53 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:01:53 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:01:53 INFO - Using env: {'DISPLAY': ':0', 15:01:53 INFO - 'HOME': '/home/cltbld', 15:01:53 INFO - 'LANG': 'en_US.UTF-8', 15:01:53 INFO - 'LANGUAGE': 'en_US:en', 15:01:53 INFO - 'LOGNAME': 'cltbld', 15:01:53 INFO - 'MAIL': '/var/mail/cltbld', 15:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:53 INFO - 'MOZ_NO_REMOTE': '1', 15:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:53 INFO - 'NO_EM_RESTART': '1', 15:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:53 INFO - 'PWD': '/builds/slave/test', 15:01:53 INFO - 'SHELL': '/bin/bash', 15:01:53 INFO - 'SHLVL': '1', 15:01:53 INFO - 'TERM': 'linux', 15:01:53 INFO - 'TMOUT': '86400', 15:01:53 INFO - 'USER': 'cltbld', 15:01:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:53 INFO - '_': '/tools/buildbot/bin/python'} 15:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:54 INFO - Downloading/unpacking psutil>=3.1.1 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:55 INFO - Installing collected packages: psutil 15:01:55 INFO - Running setup.py install for psutil 15:01:55 INFO - building 'psutil._psutil_linux' extension 15:01:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:01:58 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:01:58 INFO - building 'psutil._psutil_posix' extension 15:01:58 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:01:59 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:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:59 INFO - Successfully installed psutil 15:01:59 INFO - Cleaning up... 15:01:59 INFO - Return code: 0 15:01:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:01:59 INFO - Using env: {'DISPLAY': ':0', 15:01:59 INFO - 'HOME': '/home/cltbld', 15:01:59 INFO - 'LANG': 'en_US.UTF-8', 15:01:59 INFO - 'LANGUAGE': 'en_US:en', 15:01:59 INFO - 'LOGNAME': 'cltbld', 15:01:59 INFO - 'MAIL': '/var/mail/cltbld', 15:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:59 INFO - 'MOZ_NO_REMOTE': '1', 15:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:59 INFO - 'NO_EM_RESTART': '1', 15:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:59 INFO - 'PWD': '/builds/slave/test', 15:01:59 INFO - 'SHELL': '/bin/bash', 15:01:59 INFO - 'SHLVL': '1', 15:01:59 INFO - 'TERM': 'linux', 15:01:59 INFO - 'TMOUT': '86400', 15:01:59 INFO - 'USER': 'cltbld', 15:01:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:59 INFO - '_': '/tools/buildbot/bin/python'} 15:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:00 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:00 INFO - Installing collected packages: mozsystemmonitor 15:02:00 INFO - Running setup.py install for mozsystemmonitor 15:02:00 INFO - Successfully installed mozsystemmonitor 15:02:00 INFO - Cleaning up... 15:02:00 INFO - Return code: 0 15:02:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:02:00 INFO - Using env: {'DISPLAY': ':0', 15:02:00 INFO - 'HOME': '/home/cltbld', 15:02:00 INFO - 'LANG': 'en_US.UTF-8', 15:02:00 INFO - 'LANGUAGE': 'en_US:en', 15:02:00 INFO - 'LOGNAME': 'cltbld', 15:02:00 INFO - 'MAIL': '/var/mail/cltbld', 15:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:00 INFO - 'MOZ_NO_REMOTE': '1', 15:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:00 INFO - 'NO_EM_RESTART': '1', 15:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:00 INFO - 'PWD': '/builds/slave/test', 15:02:00 INFO - 'SHELL': '/bin/bash', 15:02:00 INFO - 'SHLVL': '1', 15:02:00 INFO - 'TERM': 'linux', 15:02:00 INFO - 'TMOUT': '86400', 15:02:00 INFO - 'USER': 'cltbld', 15:02:00 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:00 INFO - '_': '/tools/buildbot/bin/python'} 15:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:00 INFO - Downloading/unpacking jsonschema==2.5.1 15:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:02 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:02 INFO - warning: no files found matching '*.txt' 15:02:02 INFO - no previously-included directories found matching 'build' 15:02:02 INFO - no previously-included directories found matching 'dist' 15:02:02 INFO - no previously-included directories found matching '.git*' 15:02:02 INFO - Installing collected packages: jsonschema, functools32 15:02:02 INFO - Running setup.py install for functools32 15:02:02 INFO - warning: no files found matching '*.txt' 15:02:02 INFO - no previously-included directories found matching 'build' 15:02:02 INFO - no previously-included directories found matching 'dist' 15:02:02 INFO - no previously-included directories found matching '.git*' 15:02:02 INFO - Successfully installed jsonschema functools32 15:02:02 INFO - Cleaning up... 15:02:02 INFO - Return code: 0 15:02:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:02 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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 15:02:02 INFO - 'HOME': '/home/cltbld', 15:02:02 INFO - 'LANG': 'en_US.UTF-8', 15:02:02 INFO - 'LANGUAGE': 'en_US:en', 15:02:02 INFO - 'LOGNAME': 'cltbld', 15:02:02 INFO - 'MAIL': '/var/mail/cltbld', 15:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:02 INFO - 'MOZ_NO_REMOTE': '1', 15:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:02 INFO - 'NO_EM_RESTART': '1', 15:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:02 INFO - 'PWD': '/builds/slave/test', 15:02:02 INFO - 'SHELL': '/bin/bash', 15:02:02 INFO - 'SHLVL': '1', 15:02:02 INFO - 'TERM': 'linux', 15:02:02 INFO - 'TMOUT': '86400', 15:02:02 INFO - 'USER': 'cltbld', 15:02:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:02 INFO - '_': '/tools/buildbot/bin/python'} 15:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:02:02 INFO - Cleaning up... 15:02:02 INFO - Return code: 0 15:02:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:02 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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 15:02:02 INFO - 'HOME': '/home/cltbld', 15:02:02 INFO - 'LANG': 'en_US.UTF-8', 15:02:02 INFO - 'LANGUAGE': 'en_US:en', 15:02:02 INFO - 'LOGNAME': 'cltbld', 15:02:02 INFO - 'MAIL': '/var/mail/cltbld', 15:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:02 INFO - 'MOZ_NO_REMOTE': '1', 15:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:02 INFO - 'NO_EM_RESTART': '1', 15:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:02 INFO - 'PWD': '/builds/slave/test', 15:02:02 INFO - 'SHELL': '/bin/bash', 15:02:02 INFO - 'SHLVL': '1', 15:02:02 INFO - 'TERM': 'linux', 15:02:02 INFO - 'TMOUT': '86400', 15:02:02 INFO - 'USER': 'cltbld', 15:02:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:02 INFO - '_': '/tools/buildbot/bin/python'} 15:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:02 INFO - Downloading/unpacking blobuploader==1.2.4 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:04 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:04 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:04 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:04 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:04 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:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:04 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:04 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:04 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:04 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:04 INFO - Downloading docopt-0.6.1.tar.gz 15:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:04 INFO - Running setup.py install for blobuploader 15:02:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:04 INFO - Running setup.py install for requests 15:02:05 INFO - Running setup.py install for docopt 15:02:05 INFO - Successfully installed blobuploader requests docopt 15:02:05 INFO - Cleaning up... 15:02:05 INFO - Return code: 0 15:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:05 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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 15:02:05 INFO - 'HOME': '/home/cltbld', 15:02:05 INFO - 'LANG': 'en_US.UTF-8', 15:02:05 INFO - 'LANGUAGE': 'en_US:en', 15:02:05 INFO - 'LOGNAME': 'cltbld', 15:02:05 INFO - 'MAIL': '/var/mail/cltbld', 15:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:05 INFO - 'MOZ_NO_REMOTE': '1', 15:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:05 INFO - 'NO_EM_RESTART': '1', 15:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:05 INFO - 'PWD': '/builds/slave/test', 15:02:05 INFO - 'SHELL': '/bin/bash', 15:02:05 INFO - 'SHLVL': '1', 15:02:05 INFO - 'TERM': 'linux', 15:02:05 INFO - 'TMOUT': '86400', 15:02:05 INFO - 'USER': 'cltbld', 15:02:05 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:05 INFO - '_': '/tools/buildbot/bin/python'} 15:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:05 INFO - Running setup.py (path:/tmp/pip-3ez97_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:05 INFO - Running setup.py (path:/tmp/pip-MXMpUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:05 INFO - Running setup.py (path:/tmp/pip-17VfEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:05 INFO - Running setup.py (path:/tmp/pip-OjL1Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:05 INFO - Running setup.py (path:/tmp/pip-KDlBub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:05 INFO - Running setup.py (path:/tmp/pip-D2njaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:05 INFO - Running setup.py (path:/tmp/pip-t3V64v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:05 INFO - Running setup.py (path:/tmp/pip-P1r6MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:05 INFO - Running setup.py (path:/tmp/pip-W1lfTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:06 INFO - Running setup.py (path:/tmp/pip-iifmh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:06 INFO - Running setup.py (path:/tmp/pip-iwzcQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:06 INFO - Running setup.py (path:/tmp/pip-rT92uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:06 INFO - Running setup.py (path:/tmp/pip-PajwPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:06 INFO - Running setup.py (path:/tmp/pip-B76k9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:06 INFO - Running setup.py (path:/tmp/pip-Ibk5q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:06 INFO - Running setup.py (path:/tmp/pip-224uE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:06 INFO - Running setup.py (path:/tmp/pip-y4zJkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:06 INFO - Running setup.py install for manifestparser 15:02:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:06 INFO - Running setup.py install for mozcrash 15:02:06 INFO - Running setup.py install for mozdebug 15:02:06 INFO - Running setup.py install for mozdevice 15:02:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:06 INFO - Running setup.py install for mozfile 15:02:07 INFO - Running setup.py install for mozhttpd 15:02:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Running setup.py install for mozinfo 15:02:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Running setup.py install for mozInstall 15:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Running setup.py install for mozleak 15:02:07 INFO - Running setup.py install for mozlog 15:02:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Running setup.py install for moznetwork 15:02:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Running setup.py install for mozprocess 15:02:07 INFO - Running setup.py install for mozprofile 15:02:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:07 INFO - Running setup.py install for mozrunner 15:02:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:08 INFO - Running setup.py install for mozscreenshot 15:02:08 INFO - Running setup.py install for moztest 15:02:08 INFO - Running setup.py install for mozversion 15:02:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:08 INFO - Cleaning up... 15:02:08 INFO - Return code: 0 15:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:08 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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:08 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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 15:02:08 INFO - 'HOME': '/home/cltbld', 15:02:08 INFO - 'LANG': 'en_US.UTF-8', 15:02:08 INFO - 'LANGUAGE': 'en_US:en', 15:02:08 INFO - 'LOGNAME': 'cltbld', 15:02:08 INFO - 'MAIL': '/var/mail/cltbld', 15:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:08 INFO - 'MOZ_NO_REMOTE': '1', 15:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:08 INFO - 'NO_EM_RESTART': '1', 15:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:08 INFO - 'PWD': '/builds/slave/test', 15:02:08 INFO - 'SHELL': '/bin/bash', 15:02:08 INFO - 'SHLVL': '1', 15:02:08 INFO - 'TERM': 'linux', 15:02:08 INFO - 'TMOUT': '86400', 15:02:08 INFO - 'USER': 'cltbld', 15:02:08 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:08 INFO - '_': '/tools/buildbot/bin/python'} 15:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:08 INFO - Running setup.py (path:/tmp/pip-5hSorD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:08 INFO - Running setup.py (path:/tmp/pip-kzBSu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:08 INFO - Running setup.py (path:/tmp/pip-Rg8vyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:08 INFO - Running setup.py (path:/tmp/pip-FBTGes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:08 INFO - Running setup.py (path:/tmp/pip-HrantG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:08 INFO - Running setup.py (path:/tmp/pip-cKobDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:08 INFO - Running setup.py (path:/tmp/pip-Bq9AHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:09 INFO - Running setup.py (path:/tmp/pip-7QbNyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:09 INFO - Running setup.py (path:/tmp/pip-OlygKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:09 INFO - Running setup.py (path:/tmp/pip-LwQ6UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:09 INFO - Running setup.py (path:/tmp/pip-zkV3MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:09 INFO - Running setup.py (path:/tmp/pip-Gwk2ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:09 INFO - Running setup.py (path:/tmp/pip-136lz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:09 INFO - Running setup.py (path:/tmp/pip-M_PJvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:09 INFO - Running setup.py (path:/tmp/pip-_YeBSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:09 INFO - Running setup.py (path:/tmp/pip-M_DEZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:09 INFO - Running setup.py (path:/tmp/pip-ukCnN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:10 INFO - Downloading blessings-1.6.tar.gz 15:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:11 INFO - Installing collected packages: blessings 15:02:11 INFO - Running setup.py install for blessings 15:02:11 INFO - Successfully installed blessings 15:02:11 INFO - Cleaning up... 15:02:11 INFO - Return code: 0 15:02:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:11 INFO - Reading from file tmpfile_stdout 15:02:11 INFO - Current package versions: 15:02:11 INFO - argparse == 1.2.1 15:02:11 INFO - blessings == 1.6 15:02:11 INFO - blobuploader == 1.2.4 15:02:11 INFO - docopt == 0.6.1 15:02:11 INFO - functools32 == 3.2.3-2 15:02:11 INFO - jsonschema == 2.5.1 15:02:11 INFO - manifestparser == 1.1 15:02:11 INFO - mozInstall == 1.13 15:02:11 INFO - mozcrash == 1.0 15:02:11 INFO - mozdebug == 0.1 15:02:11 INFO - mozdevice == 0.51 15:02:11 INFO - mozfile == 1.2 15:02:11 INFO - mozhttpd == 0.7 15:02:11 INFO - mozinfo == 0.10 15:02:11 INFO - mozleak == 0.1 15:02:11 INFO - mozlog == 3.5 15:02:11 INFO - moznetwork == 0.27 15:02:11 INFO - mozprocess == 0.25 15:02:11 INFO - mozprofile == 0.28 15:02:11 INFO - mozrunner == 6.13 15:02:11 INFO - mozscreenshot == 0.1 15:02:11 INFO - mozsystemmonitor == 0.3 15:02:11 INFO - moztest == 0.8 15:02:11 INFO - mozversion == 1.4 15:02:11 INFO - psutil == 3.1.1 15:02:11 INFO - requests == 1.2.3 15:02:11 INFO - wsgiref == 0.1.2 15:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:11 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 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 15:02:11 INFO - 'HOME': '/home/cltbld', 15:02:11 INFO - 'LANG': 'en_US.UTF-8', 15:02:11 INFO - 'LANGUAGE': 'en_US:en', 15:02:11 INFO - 'LOGNAME': 'cltbld', 15:02:11 INFO - 'MAIL': '/var/mail/cltbld', 15:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:11 INFO - 'MOZ_NO_REMOTE': '1', 15:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:11 INFO - 'NO_EM_RESTART': '1', 15:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:11 INFO - 'PWD': '/builds/slave/test', 15:02:11 INFO - 'SHELL': '/bin/bash', 15:02:11 INFO - 'SHLVL': '1', 15:02:11 INFO - 'TERM': 'linux', 15:02:11 INFO - 'TMOUT': '86400', 15:02:11 INFO - 'USER': 'cltbld', 15:02:11 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:11 INFO - '_': '/tools/buildbot/bin/python'} 15:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:02:11 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:11 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 - 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:11 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 - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:02:12 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:12 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:12 INFO - Installing collected packages: simplejson 15:02:12 INFO - Running setup.py install for simplejson 15:02:12 INFO - building 'simplejson._speedups' extension 15:02:12 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:13 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:13 INFO - Successfully installed simplejson 15:02:13 INFO - Cleaning up... 15:02:13 INFO - Return code: 0 15:02:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eda1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2246a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', '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:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:02:13 INFO - Using env: {'DISPLAY': ':0', 15:02:13 INFO - 'HOME': '/home/cltbld', 15:02:13 INFO - 'LANG': 'en_US.UTF-8', 15:02:13 INFO - 'LANGUAGE': 'en_US:en', 15:02:13 INFO - 'LOGNAME': 'cltbld', 15:02:13 INFO - 'MAIL': '/var/mail/cltbld', 15:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:13 INFO - 'MOZ_NO_REMOTE': '1', 15:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:13 INFO - 'NO_EM_RESTART': '1', 15:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:13 INFO - 'PWD': '/builds/slave/test', 15:02:13 INFO - 'SHELL': '/bin/bash', 15:02:13 INFO - 'SHLVL': '1', 15:02:13 INFO - 'TERM': 'linux', 15:02:13 INFO - 'TMOUT': '86400', 15:02:13 INFO - 'USER': 'cltbld', 15:02:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:13 INFO - '_': '/tools/buildbot/bin/python'} 15:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:02:14 INFO - Cleaning up... 15:02:14 INFO - Return code: 0 15:02:14 INFO - Running post-action listener: _resource_record_post_action 15:02:14 INFO - Running post-action listener: _start_resource_monitoring 15:02:14 INFO - Starting resource monitoring. 15:02:14 INFO - [mozharness: 2017-09-19 22:02:14.089664Z] Finished create-virtualenv step (success) 15:02:14 INFO - [mozharness: 2017-09-19 22:02:14.090827Z] Running install step. 15:02:14 INFO - Running pre-action listener: _resource_record_pre_action 15:02:14 INFO - Running main action method: install 15:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:14 INFO - Reading from file tmpfile_stdout 15:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:14 INFO - Reading from file tmpfile_stdout 15:02:14 INFO - Output received: 15:02:14 INFO - Usage: mozinstall [options] installer 15:02:14 INFO - Options: 15:02:14 INFO - -h, --help show this help message and exit 15:02:14 INFO - -d DEST, --destination=DEST 15:02:14 INFO - Directory to install application into. [default: 15:02:14 INFO - "/builds/slave/test"] 15:02:14 INFO - --app=APP Application being installed. [default: firefox] 15:02:14 INFO - mkdir: /builds/slave/test/build/application 15:02:14 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:14 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:32 INFO - Reading from file tmpfile_stdout 15:02:32 INFO - Output received: 15:02:32 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:32 INFO - Running post-action listener: _resource_record_post_action 15:02:32 INFO - [mozharness: 2017-09-19 22:02:32.246459Z] Finished install step (success) 15:02:32 INFO - [mozharness: 2017-09-19 22:02:32.246603Z] Running setup-mitmproxy step. 15:02:32 INFO - Running pre-action listener: _resource_record_pre_action 15:02:32 INFO - Running main action method: setup_mitmproxy 15:02:32 INFO - Skipping: mitmproxy is not required 15:02:32 INFO - Running post-action listener: _resource_record_post_action 15:02:32 INFO - [mozharness: 2017-09-19 22:02:32.247129Z] Finished setup-mitmproxy step (success) 15:02:32 INFO - [mozharness: 2017-09-19 22:02:32.247229Z] Running run-tests step. 15:02:32 INFO - Running pre-action listener: _resource_record_pre_action 15:02:32 INFO - Running pre-action listener: _set_gcov_prefix 15:02:32 INFO - Running main action method: run_tests 15:02:32 WARNING - Try message not found. 15:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:32 INFO - Python 2.7.3 15:02:32 INFO - Return code: 0 15:02:32 INFO - grabbing minidump binary from tooltool 15:02:32 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:32 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 0x224a090>, '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 0x224ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2244f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:32 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:32 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:32 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:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:32 INFO - Return code: 0 15:02:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:32 INFO - ENV: RUST_BACKTRACE is now full 15:02:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:02:32 INFO - Using env: {'DISPLAY': ':0', 15:02:32 INFO - 'HOME': '/home/cltbld', 15:02:32 INFO - 'LANG': 'en_US.UTF-8', 15:02:32 INFO - 'LANGUAGE': 'en_US:en', 15:02:32 INFO - 'LOGNAME': 'cltbld', 15:02:32 INFO - 'MAIL': '/var/mail/cltbld', 15:02:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:32 INFO - 'MOZ_ACCELERATED': '1', 15:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:32 INFO - 'MOZ_NO_REMOTE': '1', 15:02:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:32 INFO - 'MOZ_WEBRENDER': '1', 15:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:32 INFO - 'NO_EM_RESTART': '1', 15:02:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:32 INFO - 'PWD': '/builds/slave/test', 15:02:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:32 INFO - 'RUST_BACKTRACE': 'full', 15:02:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:02:32 INFO - 'SHELL': '/bin/bash', 15:02:32 INFO - 'SHLVL': '1', 15:02:32 INFO - 'TERM': 'linux', 15:02:32 INFO - 'TMOUT': '86400', 15:02:32 INFO - 'USER': 'cltbld', 15:02:32 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:32 INFO - '_': '/tools/buildbot/bin/python'} 15:02:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:02:33 INFO - mozversion application_buildid: 20170919210608 15:02:33 INFO - mozversion application_changeset: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f 15:02:33 INFO - mozversion application_display_name: Nightly 15:02:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:33 INFO - mozversion application_name: Firefox 15:02:33 INFO - mozversion application_remotingname: firefox 15:02:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:02:33 INFO - mozversion application_vendor: Mozilla 15:02:33 INFO - mozversion application_version: 57.0a1 15:02:33 INFO - mozversion platform_buildid: 20170919210608 15:02:33 INFO - mozversion platform_changeset: c0d1f9eb2a4090ab8a06ef3560ab5d0e06c5bb1f 15:02:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:02:33 INFO - mozversion platform_version: 57.0a1 15:02:33 INFO - using testdate: 1505858553 15:02:33 INFO - actual date: 1505858553 15:02:33 INFO - starting webserver on 'localhost:46996' 15:02:33 INFO - SUITE-START | Running 2 tests 15:02:33 INFO - TEST-START | dromaeo_css 15:02:33 INFO - Initialising browser for dromaeo_css test... 15:02:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46996/getInfo.html -profile /tmp/tmpVxIEoR/profile 15:02:33 INFO - TEST-INFO | started process 3540 (/builds/slave/test/build/application/firefox/firefox http://localhost:46996/getInfo.html) 15:02:42 INFO - TEST-INFO | 3540: exit 0 15:02:42 INFO - Browser initialized. 15:02:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:42 INFO - Using env: {'DISPLAY': ':0', 15:02:42 INFO - 'HOME': '/home/cltbld', 15:02:42 INFO - 'JSGC_DISABLE_POISONING': '1', 15:02:42 INFO - 'LANG': 'en_US.UTF-8', 15:02:42 INFO - 'LANGUAGE': 'en_US:en', 15:02:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:02:42 INFO - 'LOGNAME': 'cltbld', 15:02:42 INFO - 'MAIL': '/var/mail/cltbld', 15:02:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:42 INFO - 'MOZ_ACCELERATED': '1', 15:02:42 INFO - 'MOZ_CRASHREPORTER': '1', 15:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:02:42 INFO - 'MOZ_NO_REMOTE': '1', 15:02:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:42 INFO - 'MOZ_WEBRENDER': '1', 15:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:42 INFO - 'NO_EM_RESTART': '1', 15:02:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:42 INFO - 'PWD': '/builds/slave/test', 15:02:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:42 INFO - 'RUST_BACKTRACE': 'full', 15:02:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:02:42 INFO - 'SHELL': '/bin/bash', 15:02:42 INFO - 'SHLVL': '1', 15:02:42 INFO - 'TERM': 'linux', 15:02:42 INFO - 'TMOUT': '86400', 15:02:42 INFO - 'USER': 'cltbld', 15:02:42 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:42 INFO - '_': '/tools/buildbot/bin/python'} 15:02:42 INFO - TEST-INFO | started process 3782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVxIEoR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:43 INFO - PID 3782 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:02:43 INFO - PID 3782 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:02:43 INFO - PID 3782 | 15:02:43 INFO - PID 3782 | (/builds/slave/test/build/application/firefox/firefox:3842): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:02:43 INFO - PID 3782 | 15:02:53 INFO - PID 3782 | RSS: Main: 185405440 15:02:53 INFO - PID 3782 | 15:05:51 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:46996/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46996/tests/dromaeo/cssquery-ext.html) 15:05:52 INFO - PID 3782 | RSS: Main: 190365696 15:05:52 INFO - PID 3782 | 15:08:55 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:46996/tests/dromaeo/cssquery-ext.html (next: http://localhost:46996/tests/dromaeo/cssquery-jquery.html) 15:08:55 INFO - PID 3782 | RSS: Main: 188817408 15:08:55 INFO - PID 3782 | 15:11:57 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:46996/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46996/tests/dromaeo/cssquery-mootools.html) 15:11:58 INFO - PID 3782 | RSS: Main: 192212992 15:11:58 INFO - PID 3782 | 15:15:00 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:46996/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46996/tests/dromaeo/cssquery-prototype.html) 15:15:01 INFO - PID 3782 | RSS: Main: 188104704 15:15:01 INFO - PID 3782 | 15:18:04 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:46996/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46996/tests/dromaeo/cssquery-yui.html) 15:18:05 INFO - PID 3782 | RSS: Main: 190193664 15:18:05 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:46996/tests/dromaeo/cssquery-yui.html (next: http://localhost:46996/tests/dromaeo/cssquery-dojo.html) 15:21:07 INFO - PID 3782 | RSS: Main: 189648896 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | __start_tp_report 15:21:07 INFO - PID 3782 | _x_x_mozilla_page_load 15:21:07 INFO - PID 3782 | _x_x_mozilla_page_load_details 15:21:07 INFO - PID 3782 | |i|pagename|runs| 15:21:07 INFO - PID 3782 | |0;dojo.html;3108.953365699514;3124.9843750781242;3157.352742687749;3160.3679264147167;3161.336119414923;6174.259088909326;6241.500679945605;6262.561620686548;6302.432781049704;6364.363563643633;6120.296165940918;6189.566730328879;6208.968955155218;6210.223722034746;6234.438900498954;5665.716714164275;5720.599558030939;5724.656520608756;5730.79942202023;5731.340895796974;5774.422557744234;5837.5913686041995;5867.442592953663;5873.70631468427;5905.970470147643;5765.625234359753;5814.941850581482;5828.970855145718;5830.533557315426;5866.76532938682;969.6884822105194;5600.103983362683;5652.3217213934595;5757.798477053304;5824.126381042856;5186.247994040843;5639.520640745542;5734.340550836624;5737.713114344266;5750.683712395817;6049.939500604982;6209.820134174538;6220.502359811204;6269.529785266123;6300.527460440485;6637.46900247979;6642.468602511835;6660.800175994728;6729.966350168218;6731;6702.497312701566;6722.092517510123;6799.11611490508;6805.48958828085;6807.5575087619145;6205.565610407273;6232.283287421914;6244.87510249797;6280.717367718464;6302.46429053531;6752;6847.144106986627;6878.58728476293;6898.413634840995;6903.6203008835;6482.319356467598;6542.967285163639;6576.309487503743;6583.80248592543;6589.4069533742195;6572.178477690289;6671.066050752898;6684.431823294977;6696.665166741741;6755.831104222336;6645.534812563171;6646.634435106019;6707.6981535831;6730;6749.966250168816;6512.706928188243;6670.7665231716655;6714.798556043326;6750.527463077636;6760.323967603299;5164.586833053347;5259.132243179909;5297.867553311121;5299.364076310867;5308;4635.490096089427;4639.744814035261;4649.395578574764;4667.229907065296;4697.13103075932;5737.282839645044;5795.1017592273265;5826.213461182686;5826.650400975955;5828.125781132864;6661.26726060133;6725.9663701681175;6758.256591774901;6828.556143850634;6848.657567121624;5565.7217139143695;5657.151427285858;5664.348599910981;5690.4025077367105;5691.886162276731;5453.754581043862;5455.399906010336;5468.699221542854;5475.151351540518;5480.725963701799;6351.491880649537;6368.076628888785;6392.360763923571;6461.61230326182;6476.546641735127;6738.932610673831;6747.797566073025;6760.459163267025;6808.62552559614;6831.487638427038;6399.232092148972;6465;6483.124778154889;6531.085648009187;6546.738130474728;6501.187351581052;6595.934040659724;6635.4359879410795;6641.203055633355;6642.800715978528;6661.533692641468;6695.296993815579;6733.225679046972;6734.562253453706;6745.494087943522;6452.903206451813;6453.967730161319;6457.096006558992;6478.093066970534;6490.837729056811;6430.324815894263;6475.222973243241;6515.413612774873;6537.934620653923;6562.737490500326;6283.59156654816;6323.494120470259;6405;6476.060971159061;6508.576942498722;6541.574797638138;6588.044733513518;6614.933850661432;6624.337566243337;6632.933670663231;6355.586886852339;6370.203724534434;6389.393007664265;6427.421532062137;6483.027545868157 15:21:07 INFO - PID 3782 | |1;ext.html;844.9366297527686;862.3144600042965;865.7489328094853;870.30810505648;874.0822136756404;37229.25541489172;40779.59220407795;41193;41237.38143927843;41451.79274103629;38005.61994380056;38361.23277534448;38482.230355392945;38657.80671096648;38663.806680966554;7217.314355136254;7277.381422579061;7313.56118632881;7317.890231646503;7334.889976650355;7865.488743231672;8047.597620118971;8076.555789431579;8082.838343233132;8087.919120808775;8010.239027292427;8025.879611805827;8048.034235891701;8090.110087890327;8102.270795628392;7846.686132554691;7932.643031063616;7984.640691168882;8082.515049097073;8107.756767296991;7891.408144389194;7969.322607578363;7979.840403191962;7983.72056978003;7985.720499782537;37889.621103788886;38404.615953840665;38457.23085538274;38551.61448385508;38579.80710096432;3520.2431477232517;3529.2412131391875;3532.8056956867363;3532.9646703532894;3552.626974167701;31104.533431998538;31473.685263147305;31587.52618710721;31635;31767.682323176705;5218.921716174261;5221.503957124067;5249.947500524984;5283.445238250005;5327.920081198785;173880;174063;174706;175036;175900;40763.79618101891;47380.289295660594;47580.28629570559;47628.28557571639;47655.046899062516;43584.78207608942;43604;50208;51163.48836511662;51375.48624513782;16162.515124546282;16394.26225819817;16399.83600163983;16548.172591370385;16581.419650312182;13448.596542103753;13514.189148651112;13519.324033798272;13544.661383465493;13583.796243056362;14348.06737562055;14385.64035899111;14385.85614143866;14402.855971440362;14578.85421145775;5690.459406356389;5716.857078573069;5767.971814797181;5842.620229685142;5901.527877769769;976.0673865745721;998.8901220865699;1002.834532302162;1013.1135256650431;1016.0956748493846;22401.887990559942;22437.21469748551;22637.094516219167;22746.886265568897;22817.657735133987;1093.436880006797;1108.4070022538065;1114.1365441782684;1115.8214685650257;1127.2729089737074;11854.407279635983;12045.156839021185;12050.216735912138;12138.514459421523;12206.267623942593;216253;217376;218928;220024;220179;51079.744601276754;51266.23100653493;51320.23019654708;51514.74242628763;51635.48364516382;1400.7898815177805;1459.1245252848207;1460.3136525833054;1473.5505670770517;1480.3560451203762;22196;22678.319650410514;22700.65949010799;22707.659385108906;22733.886330568243;36506.26987460183;36632.81683591672;36798.080047999014;36928.44607330838;37089.62910370862;181250;181421;181518;182189;182463;29758.702412976458;30446.695533044385;30722.846385767927;33744.15639609029;35610.82194589011;41432.3785143217;43435.56564434442;43789.34315985326;43951.560484396025;44150;31947.520787188674;32473.188170294987;32517;32571.837140814143;32782.34435311328;31076;31293.194943420607;31372.529412059295;31875.84062079675;32099.35801284008;35757.46363804597;35927.461088083175;35990;36030.8198459006;36043.27913441664;30975;30997.225069373446;31356.529652055695;31439.84280078585;31472;22943.196988105337;23095;23238.535229295656;23541.17605883786;23892.522149556564 15:21:07 INFO - PID 3782 | |2;jquery.html;555.1339909740807;557.3395526301333;566.6568738267265;570.7403131575136;583.6906439587019;22220.88889555552;22632.321030369094;22751.203707870227;22912.427189320275;22931.082756689713;23214.76785232147;24433.144839930606;24444;24703.876480617615;24815.875920620416;6483.254425741029;6610.338966103399;6644.93355066448;6649.667516624149;6658.167729033871;6295.118683384329;6518.087467754518;6554.606723596599;6558.114654521626;6597.2083349998065;6519.413252807246;6527.836804079889;6553.606783593;6556.836079098013;6582.275949645536;6507.544471886946;6552.672366381686;6571.57284776488;6572.112764776742;6579.539432239745;5892.381299963485;6058.848528786815;6081.756729730805;6084.209052823149;6085.939140608626;27262.5910611341;27441.17676469709;27578.862105689343;27671.58492622612;27803.58294625582;2086.2072412483312;2138.4119367173994;2138.764735879052;2140.3257973738378;2140.593287275413;18641.906790466095;19241.61516769671;19591.118399671905;19632.901835490873;19696.70454943177;2363.2555744940287;2407.903683852644;2410.0239403041796;2430.2466235467064;2431.161249368965;120242.39878800638;125373;128922;134921;136621;14155.433782648784;14314.498992535211;14340.21128837924;14481.927590362191;14662.046966947328;22776.088956441556;22785.20251791179;22798.65802012971;22826.201082962016;22893.542129157322;9712.61149554024;10166;10225.48872556384;10225.642102526375;10308.587656493657;9504.857427138599;9545.188658964065;9618.086281803218;9684.75788105303;9777.120059194707;8808.471491710518;8842.027376988526;8995.55022248885;9005.864912026325;9166.908330916738;2543.9491210175693;2668.759811616925;2715.2804506805714;2722.333028408013;2729.7406746359065;940.5062342270363;985.4727720669407;988.0564061321421;995.0845222395413;996.9900300997042;18762.906185468986;18947.33684321042;19083.713744293847;19099.140538675794;19644.607107857762;1010.5553556435145;1029.3206483720708;1030.2685093583489;1041.7916416716687;1042.4891803016467;10231.9488402559;10567.947160264303;10704.625338113128;10734.78530429387;10801.405922674328;452399;456913;465610;473511;476002;109100;111970.44014779874;114409;115800;120813.39593302153;1026.9897301027042;1131.6095946898306;1150.1546363423045;1191.6365508519984;1192.5170306026073;19675.31136410219;19678.90160549188;19761.70357444668;20271;20341.898290509045;53910.730446347516;55016;56014.71992640011;56931.43068569261;57601.135982961125;70032;70073;70119.64940175267;70331.64834176001;70529.58940821052;13069.477220911058;13262.27057511846;13282.86717132855;13304.46782128704;13517.188968661912;22138.33584992453;22320.77679223187;22373.216937407113;22429.887850560644;22618.321450356514;17491.300347986446;18217.726734098735;18255;18274.90862545679;18323.90838045801;15575;16205.59486012859;16486.917565412095;16652.417165399154;16799;17972.730409044136;18162.909185453987;18184.181711823265;18523.90738046301;18781.34265300708;13157.868421315665;13187.934060329637;13214.603561893158;13288.534901278408;13419.194848309133;17757.911210443865;17778.199981000627;17926.462206133838;17966.910165449088;18156.72764908501 15:21:07 INFO - PID 3782 | |3;mootools.html;1289.6002239305815;1343.9596812095629;1354.2416246901735;1356.8914486841054;1357.6198664373967;13995.999999999987;14461.783073253897;14580.125192488458;14656.926715366435;14675;14314.928425357884;14437.63905902353;14509.274536273171;14514;14514.201718905457;2673.6925253595796;2755.6830964439046;2777.791665625076;2778.597103420003;2779.291280723413;2654.86725663717;2697.9190624281305;2745.2450576091533;2745.9725402746017;2747.835129892213;2539.7841183499427;2669.546177149889;2747.5603903375463;2755.7657599104;2758.8758505867186;2666.4533770576986;2670.2923725212836;2692.407670312528;2707.0795929384008;2713.945721085567;2576.0726138590094;2620.7903367730537;2621.934451638705;2622.645942797736;2661.188337557044;14252;14257;14301.92849035748;14341.641458963504;14388.208648524327;7520.8119797004965;8061.193880611951;8090.474119182234;8169.468984515987;8173;5251.107311756972;5522.199281104257;5584.078627026536;5585.581081418869;5600.691961942091;1835.3851459760997;1857.5263307856546;1862.4040307101732;1905.2093381246766;1917.8561607879326;24226.515469690683;24404.02383904642;24433.144839930515;24571;24628.138015169385;6487.572733998512;6525.314841941527;6538.901916471256;6597.2742998271115;6713.0266111413575;16264.186790660657;16280.674386512203;16346.264418100976;16410.507684769476;16491;7524.548527088392;7764.417668674872;7775.883361749578;7803.180666030099;7864.056313242333;7198.748043818546;7252.891206631904;7339.339459448675;7382.852342953111;7399.149097853708;4934.4572097069295;5071.340725705634;5147.510986456281;5149.794008239628;5209.583233341324;1302.9674258143432;1487.278669845146;1490.8967364150667;1491.7469325766192;1517.1352329172266;742.5693098003145;873.0352959979132;890.0832142892831;895.91936725695;908.3142227618106;7216.9278307216255;7302.780916572405;7308.96345518269;7324.2309557496765;7346.595937223504;975.1759763000254;1010.7271036820017;1013.9391636501833;1014.6043043213152;1022.994885025585;4468.977655111768;4531.77341132942;4581.496035436099;4593.379893714373;4637.582617564435;19850.90074549618;19933.302334418226;20060.799392006185;20199.899000505196;20384.694229586567;19469.707954380694;20114.597708045756;20310.593788124155;20328;20415.285465008652;10321.071103600712;10468;10580.52387642558;10582.100521455763;10621.787564248672;8035.236652518001;8064;8106.47307924983;8151.714689985822;8182.795430114056;17572.91213543924;17828.821711782715;17921.551961201076;18043.729344059586;18296.359627412978;17832.19755110997;17905.731414029062;18251.269949201884;18507.537311567317;18630.161642725838;10277.486125693536;10373.688789336333;10520.105791007543;10550;10553.841692374774;12929.935350323565;13115.540956066492;13138.540151094665;13249.735005300034;13252.20486770797;10772.622958196425;10977.945110274717;11036;11042.723931901766;11047.779044419227;10228.07947284748;10292.433916134685;10512.842307365243;10535.578576857146;10567.577296908345;9380.827396575429;9405.905940940504;9612.375195612543;9649.228061755182;9663.371880827724;7216.855662886608;7411.110666720028;7451.850962980819;7490.550566966;7522.134954480086;6881.13985751781;7055.894161587683;7065.116860392451;7209.4592905533345;7296.927030729625 15:21:07 INFO - PID 3782 | |4;prototype.html;483.7194427232206;515.9380874295084;516.8139469790875;522.6785526900954;524.6773234460808;6324.494040476762;6403.263624683163;6405.743770249196;6415.781001609691;6442.162518872546;6248.500119990401;6289.49684025278;6357.777477788279;6369.299377068519;6382.553221274513;5231.398389185245;5284.497972692608;5301.787928482856;5301.946980530203;5324.387695415019;5234.7120908350025;5236.659617124894;5263.210518422248;5264.894702105956;5326.227696983935;4892.315075889378;5075.340205773263;5075.5178258065425;5081.517255860687;5092;5034.647574669774;5075;5081.085404627165;5095.847124586268;5132.769025393847;4530.207213737583;4538.523455037207;4567.2920697291975;4569.817207311737;4577.29051996941;5998.8500287492725;6149.692515374213;6156.599821011665;6266.717997690115;6270.623762574214;5704.258446401941;5749.3388260350175;5793.797217097382;5816.8947899898885;5841.88316233673;6604.240512341046;6607.80176594703;6644.069830223772;6652;6714.971017389576;4948.6288528360155;4954.554090131869;4964.453910069889;4974.980129073568;4976.4525902150735;6596.472282217411;6882.621455819978;6917.169939607229;6995.79012629622;7023.719051237893;5513.173024046345;5533.114701647797;5554.888902222014;5573.164025396223;5597.524210442077;5587.776488940478;5626.2967129108865;5666.603337766399;5685.403032681592;5711.514521265739;6049.425304596057;6059.394060593993;6095.116208149882;6106.267247930188;6130.325664176937;6647.468202543785;6709.19489661234;6739.393454589111;6788.796336109925;6823.249442561314;1965.4889728670362;1968.6161198566429;1970.7930667280016;1976.3478052242726;1990.8705934114237;1359.7212571422835;1446.3491428857055;1448.304813689414;1451.978220326696;1474.8303945046243;5752.884942301214;5760.185541554397;5782.566307526952;5804.477597016289;5830.941690583039;6720.7647732330115;6757.256701762803;6779.389854912983;6806.251312355637;6850.554713943578;5646.2942132233475;5705.4579814917515;5714.714264286769;5753.539716822728;5789.536837053026;3580.409232476612;3605.351036813399;3632.6398081774782;3634.473001414833;3640.28906413985;6482.902756458657;6496.285408605049;6500.317466666026;6543.1821022372205;6601.768938087144;7017.228104908456;7033.402160816286;7047.0452467664745;7067.293270672892;7088.3974862136265;6508.739650414025;6557.082008518812;6557.311482294386;6560.639164845979;6649.268580456146;6769.323067693388;6771.695273712597;6861.691223894837;6906.102206713095;6908.723651053901;6693.698783554654;6737.696803643946;6761.667224807434;6781.966090169518;6838.213605435439;6389.594289256356;6431.646259455775;6491.156149700509;6498.642574658439;6511.21865376139;5479.643823151482;5485.177223416519;5525.696086715269;5526.143447765603;5555.472230138131;6504.0243963405865;6527.379898909596;6635.867282654416;6718.596884186964;6729.5625784323865;6553.869992252632;6557.344265573595;6593.835154121185;6611.438027767501;6638.601683898982;6428.935710642833;6434;6497.9025314619375;6560.442362399059;6582.1443212384;6241.875162496815;6438.9697648377905;6469.417752402306;6501.6099034056215;6516.152900122954;6571.34286571339;6583.703733331916;6611.966940165268;6615.702293396713;6717.731290748316;6404.775832845828;6452.193475815523;6473.838154046187;6494.155759751202;6532.8366790830605 15:21:07 INFO - PID 3782 | |5;yui.html;909.3361845852528;912.0560220172123;915.0346384564282;927.1099744245524;938.4932136646212;18653.72019419708;19117.330893418733;19182.712259316122;19224.71162932557;19319.13063912124;17003.149842507886;17138.828611713878;17141.400050998218;17445.912770436164;17537.912310438463;947.322664295029;948.4972964328916;951.8572214167896;955.1499165742495;958.3818437108096;967.9516024198762;976.9658061967832;979.7158823941048;985.8028394321165;986.7878406142678;972.3436680240844;1013.2856336282903;1019.1031891935087;1020.5203554329453;1024.938503689781;1017.64382466137;1018.9898101018969;1019.2966852871494;1021.1677482851527;1021.5658345203259;726.1902978179291;745.7054463486946;750.2422553221231;753.868073087213;755.1278273593953;19390.515237119045;19783.80216197834;19788.604227915363;19809.9009504953;19845.9007704962;21233.25683601082;21350;21915.452113697127;22111.668324975137;22130.88934555317;16485.17574121301;16692.415765448273;16762.161891905478;16875.409360672442;16933.745993810102;3717.9070523237137;3739.925201495982;3743.2513497300647;3752.3620984432714;3755.455458958463;106034;129784;130398.3480082603;139471;142431.28784356115;17333.133343333036;17568.648627027644;17796.3771268005;17918.820811791975;17963.281468741367;31516.684833151834;31527.84236078805;31985.68014319827;32113.51829722556;32274.515882261785;8877.422967507091;9094.772630684154;9105.317101217435;9122.498262595622;9144.81710365789;4209.431726716915;4250.36244563318;4267.3598960155605;4273.1026484438;4283;5388.191771234347;5481.588880833953;5482.068048431776;5485.122380419114;5494.835154945358;1031.0771859186136;1069.2675517270695;1071.4160782373624;1072.1101485766794;1085.9239853210358;624.5815303746501;642.9935700643027;659.5679829711546;662.0730976632752;663.9502037347219;11366.374849383197;11692.649220523397;11838.099665581987;11883;12107.39463026845;632.1623848400887;636.8630744389978;646.7186773753432;649.694643517546;657.1686816177539;5795.971020144872;5797.710114494258;5826.271716035496;5930.140129681172;5945.40545945402;124345;124444;125470;125483;127504.36247818702;86417.56791216004;98525.50737246269;106272.37199113863;108552;108749;88591.11408885957;89088;90001;90853;91568.08431915595;12774.936125319315;13189.934050329686;13309.933450332686;13361.13152645075;13399;41500.169996599296;42285.788571056946;42352;43073.569264306956;43301.3504797422;55748.44251557432;56109.15836262541;56110;57063.14405283841;58225.70887145537;18328.266869325078;18490.722639160693;18542.907285464025;18610.906945465187;18831.435056948314;18944.905275473535;19315.8068419314;19393.612127757082;19518.21927122899;19672.409827705193;18527.166277517812;19018.23927042958;19121.426357209308;19351.709724353863;19492;14877.256137193313;14977.400903964155;14994.400223990919;15036.173010484528;15073.698526029637;15815.68368632644;15831.68336633284;15932.522024339289;16000.359985600911;16016.679666406373;12359.32023738667;12438.256851497727;12466.812997805222;12526.561570344995;12571.434285456993;14400.495982640557;14467.638309041937;14507.709845802814;14518.056326338754;14583.92708036453 15:21:07 INFO - PID 3782 | __end_tp_report 15:21:07 INFO - PID 3782 | __start_cc_report 15:21:07 INFO - PID 3782 | _x_x_mozilla_cycle_collect,295 15:21:07 INFO - PID 3782 | __end_cc_report 15:21:07 INFO - PID 3782 | __startTimestamp1505859667826__endTimestamp 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | ------- Summary: start ------- 15:21:07 INFO - PID 3782 | Number of tests: 6 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | [#0] dojo.html Cycles:165 Average:6112.59 Median:6399.23 stddev:844.87 (13.2%) stddev-sans-first:813.94 15:21:07 INFO - PID 3782 | Values: 3109.0 3125.0 3157.4 3160.4 3161.3 6174.3 6241.5 6262.6 6302.4 6364.4 6120.3 6189.6 6209.0 6210.2 6234.4 5665.7 5720.6 5724.7 5730.8 5731.3 5774.4 5837.6 5867.4 5873.7 5906.0 5765.6 5814.9 5829.0 5830.5 5866.8 969.7 5600.1 5652.3 5757.8 5824.1 5186.2 5639.5 5734.3 5737.7 5750.7 6049.9 6209.8 6220.5 6269.5 6300.5 6637.5 6642.5 6660.8 6730.0 6731.0 6702.5 6722.1 6799.1 6805.5 6807.6 6205.6 6232.3 6244.9 6280.7 6302.5 6752.0 6847.1 6878.6 6898.4 6903.6 6482.3 6543.0 6576.3 6583.8 6589.4 6572.2 6671.1 6684.4 6696.7 6755.8 6645.5 6646.6 6707.7 6730.0 6750.0 6512.7 6670.8 6714.8 6750.5 6760.3 5164.6 5259.1 5297.9 5299.4 5308.0 4635.5 4639.7 4649.4 4667.2 4697.1 5737.3 5795.1 5826.2 5826.7 5828.1 6661.3 6726.0 6758.3 6828.6 6848.7 5565.7 5657.2 5664.3 5690.4 5691.9 5453.8 5455.4 5468.7 5475.2 5480.7 6351.5 6368.1 6392.4 6461.6 6476.5 6738.9 6747.8 6760.5 6808.6 6831.5 6399.2 6465.0 6483.1 6531.1 6546.7 6501.2 6595.9 6635.4 6641.2 6642.8 6661.5 6695.3 6733.2 6734.6 6745.5 6452.9 6454.0 6457.1 6478.1 6490.8 6430.3 6475.2 6515.4 6537.9 6562.7 6283.6 6323.5 6405.0 6476.1 6508.6 6541.6 6588.0 6614.9 6624.3 6632.9 6355.6 6370.2 6389.4 6427.4 6483.0 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | [#1] ext.html Cycles:180 Average:36000.13 Median:3542.80 stddev:49774.71 (1405.0%) stddev-sans-first:49844.34 15:21:07 INFO - PID 3782 | Values: 844.9 862.3 865.7 870.3 874.1 37229.3 40779.6 41193.0 41237.4 41451.8 38005.6 38361.2 38482.2 38657.8 38663.8 7217.3 7277.4 7313.6 7317.9 7334.9 7865.5 8047.6 8076.6 8082.8 8087.9 8010.2 8025.9 8048.0 8090.1 8102.3 7846.7 7932.6 7984.6 8082.5 8107.8 7891.4 7969.3 7979.8 7983.7 7985.7 37889.6 38404.6 38457.2 38551.6 38579.8 3520.2 3529.2 3532.8 3533.0 3552.6 31104.5 31473.7 31587.5 31635.0 31767.7 5218.9 5221.5 5249.9 5283.4 5327.9 173880.0 174063.0 174706.0 175036.0 175900.0 40763.8 47380.3 47580.3 47628.3 47655.0 43584.8 43604.0 50208.0 51163.5 51375.5 16162.5 16394.3 16399.8 16548.2 16581.4 13448.6 13514.2 13519.3 13544.7 13583.8 14348.1 14385.6 14385.9 14402.9 14578.9 5690.5 5716.9 5768.0 5842.6 5901.5 976.1 998.9 1002.8 1013.1 1016.1 22401.9 22437.2 22637.1 22746.9 22817.7 1093.4 1108.4 1114.1 1115.8 1127.3 11854.4 12045.2 12050.2 12138.5 12206.3 216253.0 217376.0 218928.0 220024.0 220179.0 51079.7 51266.2 51320.2 51514.7 51635.5 1400.8 1459.1 1460.3 1473.6 1480.4 22196.0 22678.3 22700.7 22707.7 22733.9 36506.3 36632.8 36798.1 36928.4 37089.6 181250.0 181421.0 181518.0 182189.0 182463.0 29758.7 30446.7 30722.8 33744.2 35610.8 41432.4 43435.6 43789.3 43951.6 44150.0 31947.5 32473.2 32517.0 32571.8 32782.3 31076.0 31293.2 31372.5 31875.8 32099.4 35757.5 35927.5 35990.0 36030.8 36043.3 30975.0 30997.2 31356.5 31439.8 31472.0 22943.2 23095.0 23238.5 23541.2 23892.5 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | [#2] jquery.html Cycles:180 Average:33526.36 Median:22691.76 stddev:78407.78 (345.5%) stddev-sans-first:78588.65 15:21:07 INFO - PID 3782 | Values: 555.1 557.3 566.7 570.7 583.7 22220.9 22632.3 22751.2 22912.4 22931.1 23214.8 24433.1 24444.0 24703.9 24815.9 6483.3 6610.3 6644.9 6649.7 6658.2 6295.1 6518.1 6554.6 6558.1 6597.2 6519.4 6527.8 6553.6 6556.8 6582.3 6507.5 6552.7 6571.6 6572.1 6579.5 5892.4 6058.8 6081.8 6084.2 6085.9 27262.6 27441.2 27578.9 27671.6 27803.6 2086.2 2138.4 2138.8 2140.3 2140.6 18641.9 19241.6 19591.1 19632.9 19696.7 2363.3 2407.9 2410.0 2430.2 2431.2 120242.4 125373.0 128922.0 134921.0 136621.0 14155.4 14314.5 14340.2 14481.9 14662.0 22776.1 22785.2 22798.7 22826.2 22893.5 9712.6 10166.0 10225.5 10225.6 10308.6 9504.9 9545.2 9618.1 9684.8 9777.1 8808.5 8842.0 8995.6 9005.9 9166.9 2543.9 2668.8 2715.3 2722.3 2729.7 940.5 985.5 988.1 995.1 997.0 18762.9 18947.3 19083.7 19099.1 19644.6 1010.6 1029.3 1030.3 1041.8 1042.5 10231.9 10567.9 10704.6 10734.8 10801.4 452399.0 456913.0 465610.0 473511.0 476002.0 109100.0 111970.4 114409.0 115800.0 120813.4 1027.0 1131.6 1150.2 1191.6 1192.5 19675.3 19678.9 19761.7 20271.0 20341.9 53910.7 55016.0 56014.7 56931.4 57601.1 70032.0 70073.0 70119.6 70331.6 70529.6 13069.5 13262.3 13282.9 13304.5 13517.2 22138.3 22320.8 22373.2 22429.9 22618.3 17491.3 18217.7 18255.0 18274.9 18323.9 15575.0 16205.6 16486.9 16652.4 16799.0 17972.7 18162.9 18184.2 18523.9 18781.3 13157.9 13187.9 13214.6 13288.5 13419.2 17757.9 17778.2 17926.5 17966.9 18156.7 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | [#3] mootools.html Cycles:180 Average:8895.37 Median:2598.43 stddev:6217.32 (239.3%) stddev-sans-first:6208.49 15:21:07 INFO - PID 3782 | Values: 1289.6 1344.0 1354.2 1356.9 1357.6 13996.0 14461.8 14580.1 14656.9 14675.0 14314.9 14437.6 14509.3 14514.0 14514.2 2673.7 2755.7 2777.8 2778.6 2779.3 2654.9 2697.9 2745.2 2746.0 2747.8 2539.8 2669.5 2747.6 2755.8 2758.9 2666.5 2670.3 2692.4 2707.1 2713.9 2576.1 2620.8 2621.9 2622.6 2661.2 14252.0 14257.0 14301.9 14341.6 14388.2 7520.8 8061.2 8090.5 8169.5 8173.0 5251.1 5522.2 5584.1 5585.6 5600.7 1835.4 1857.5 1862.4 1905.2 1917.9 24226.5 24404.0 24433.1 24571.0 24628.1 6487.6 6525.3 6538.9 6597.3 6713.0 16264.2 16280.7 16346.3 16410.5 16491.0 7524.5 7764.4 7775.9 7803.2 7864.1 7198.7 7252.9 7339.3 7382.9 7399.1 4934.5 5071.3 5147.5 5149.8 5209.6 1303.0 1487.3 1490.9 1491.7 1517.1 742.6 873.0 890.1 895.9 908.3 7216.9 7302.8 7309.0 7324.2 7346.6 975.2 1010.7 1013.9 1014.6 1023.0 4469.0 4531.8 4581.5 4593.4 4637.6 19850.9 19933.3 20060.8 20199.9 20384.7 19469.7 20114.6 20310.6 20328.0 20415.3 10321.1 10468.0 10580.5 10582.1 10621.8 8035.2 8064.0 8106.5 8151.7 8182.8 17572.9 17828.8 17921.6 18043.7 18296.4 17832.2 17905.7 18251.3 18507.5 18630.2 10277.5 10373.7 10520.1 10550.0 10553.8 12929.9 13115.5 13138.5 13249.7 13252.2 10772.6 10977.9 11036.0 11042.7 11047.8 10228.1 10292.4 10512.8 10535.6 10567.6 9380.8 9405.9 9612.4 9649.2 9663.4 7216.9 7411.1 7451.9 7490.6 7522.1 6881.1 7055.9 7065.1 7209.5 7296.9 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | [#4] prototype.html Cycles:180 Average:5645.74 Median:6268.67 stddev:1520.24 (24.3%) stddev-sans-first:1474.31 15:21:07 INFO - PID 3782 | Values: 483.7 515.9 516.8 522.7 524.7 6324.5 6403.3 6405.7 6415.8 6442.2 6248.5 6289.5 6357.8 6369.3 6382.6 5231.4 5284.5 5301.8 5301.9 5324.4 5234.7 5236.7 5263.2 5264.9 5326.2 4892.3 5075.3 5075.5 5081.5 5092.0 5034.6 5075.0 5081.1 5095.8 5132.8 4530.2 4538.5 4567.3 4569.8 4577.3 5998.9 6149.7 6156.6 6266.7 6270.6 5704.3 5749.3 5793.8 5816.9 5841.9 6604.2 6607.8 6644.1 6652.0 6715.0 4948.6 4954.6 4964.5 4975.0 4976.5 6596.5 6882.6 6917.2 6995.8 7023.7 5513.2 5533.1 5554.9 5573.2 5597.5 5587.8 5626.3 5666.6 5685.4 5711.5 6049.4 6059.4 6095.1 6106.3 6130.3 6647.5 6709.2 6739.4 6788.8 6823.2 1965.5 1968.6 1970.8 1976.3 1990.9 1359.7 1446.3 1448.3 1452.0 1474.8 5752.9 5760.2 5782.6 5804.5 5830.9 6720.8 6757.3 6779.4 6806.3 6850.6 5646.3 5705.5 5714.7 5753.5 5789.5 3580.4 3605.4 3632.6 3634.5 3640.3 6482.9 6496.3 6500.3 6543.2 6601.8 7017.2 7033.4 7047.0 7067.3 7088.4 6508.7 6557.1 6557.3 6560.6 6649.3 6769.3 6771.7 6861.7 6906.1 6908.7 6693.7 6737.7 6761.7 6782.0 6838.2 6389.6 6431.6 6491.2 6498.6 6511.2 5479.6 5485.2 5525.7 5526.1 5555.5 6504.0 6527.4 6635.9 6718.6 6729.6 6553.9 6557.3 6593.8 6611.4 6638.6 6428.9 6434.0 6497.9 6560.4 6582.1 6241.9 6439.0 6469.4 6501.6 6516.2 6571.3 6583.7 6612.0 6615.7 6717.7 6404.8 6452.2 6473.8 6494.2 6532.8 15:21:07 INFO - PID 3782 | 15:21:07 INFO - PID 3782 | [#5] yui.html Cycles:180 Average:24066.74 Median:19505.11 stddev:33822.84 (173.4%) stddev-sans-first:33873.02 15:21:07 INFO - PID 3782 | Values: 909.3 912.1 915.0 927.1 938.5 18653.7 19117.3 19182.7 19224.7 19319.1 17003.1 17138.8 17141.4 17445.9 17537.9 947.3 948.5 951.9 955.1 958.4 968.0 977.0 979.7 985.8 986.8 972.3 1013.3 1019.1 1020.5 1024.9 1017.6 1019.0 1019.3 1021.2 1021.6 726.2 745.7 750.2 753.9 755.1 19390.5 19783.8 19788.6 19809.9 19845.9 21233.3 21350.0 21915.5 22111.7 22130.9 16485.2 16692.4 16762.2 16875.4 16933.7 3717.9 3739.9 3743.3 3752.4 3755.5 106034.0 129784.0 130398.3 139471.0 142431.3 17333.1 17568.6 17796.4 17918.8 17963.3 31516.7 31527.8 31985.7 32113.5 32274.5 8877.4 9094.8 9105.3 9122.5 9144.8 4209.4 4250.4 4267.4 4273.1 4283.0 5388.2 5481.6 5482.1 5485.1 5494.8 1031.1 1069.3 1071.4 1072.1 1085.9 624.6 643.0 659.6 662.1 664.0 11366.4 11692.6 11838.1 11883.0 12107.4 632.2 636.9 646.7 649.7 657.2 5796.0 5797.7 5826.3 5930.1 5945.4 124345.0 124444.0 125470.0 125483.0 127504.4 86417.6 98525.5 106272.4 108552.0 108749.0 88591.1 89088.0 90001.0 90853.0 91568.1 12774.9 13189.9 13309.9 13361.1 13399.0 41500.2 42285.8 42352.0 43073.6 43301.4 55748.4 56109.2 56110.0 57063.1 58225.7 18328.3 18490.7 18542.9 18610.9 18831.4 18944.9 19315.8 19393.6 19518.2 19672.4 18527.2 19018.2 19121.4 19351.7 19492.0 14877.3 14977.4 14994.4 15036.2 15073.7 15815.7 15831.7 15932.5 16000.4 16016.7 12359.3 12438.3 12466.8 12526.6 12571.4 14400.5 14467.6 14507.7 14518.1 14583.9 15:21:07 INFO - PID 3782 | -------- Summary: end -------- 15:21:07 INFO - PID 3782 | 15:21:08 INFO - TEST-INFO | 3782: exit 0 15:21:08 INFO - TEST-OK | dromaeo_css | took 1115469ms 15:21:08 INFO - TEST-START | kraken 15:21:08 INFO - Initialising browser for kraken test... 15:21:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46996/getInfo.html -profile /tmp/tmpLBIY1p/profile 15:21:08 INFO - TEST-INFO | started process 4165 (/builds/slave/test/build/application/firefox/firefox http://localhost:46996/getInfo.html) 15:21:15 INFO - TEST-INFO | 4165: exit 0 15:21:15 INFO - Browser initialized. 15:21:15 INFO - Running cycle 1/1 for kraken test... 15:21:15 INFO - Using env: {'DISPLAY': ':0', 15:21:15 INFO - 'HOME': '/home/cltbld', 15:21:15 INFO - 'JSGC_DISABLE_POISONING': '1', 15:21:15 INFO - 'LANG': 'en_US.UTF-8', 15:21:15 INFO - 'LANGUAGE': 'en_US:en', 15:21:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:21:15 INFO - 'LOGNAME': 'cltbld', 15:21:15 INFO - 'MAIL': '/var/mail/cltbld', 15:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:15 INFO - 'MOZ_ACCELERATED': '1', 15:21:15 INFO - 'MOZ_CRASHREPORTER': '1', 15:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:21:15 INFO - 'MOZ_NO_REMOTE': '1', 15:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:15 INFO - 'MOZ_WEBRENDER': '1', 15:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:15 INFO - 'NO_EM_RESTART': '1', 15:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:15 INFO - 'PWD': '/builds/slave/test', 15:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:15 INFO - 'RUST_BACKTRACE': 'full', 15:21:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:21:15 INFO - 'SHELL': '/bin/bash', 15:21:15 INFO - 'SHLVL': '1', 15:21:15 INFO - 'TERM': 'linux', 15:21:15 INFO - 'TMOUT': '86400', 15:21:15 INFO - 'USER': 'cltbld', 15:21:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944', 15:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:15 INFO - '_': '/tools/buildbot/bin/python'} 15:21:15 INFO - TEST-INFO | started process 4409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLBIY1p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:16 INFO - PID 4409 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:21:16 INFO - PID 4409 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:21:16 INFO - PID 4409 | 15:21:16 INFO - PID 4409 | (/builds/slave/test/build/application/firefox/firefox:4468): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:21:16 INFO - PID 4409 | 15:21:27 INFO - PID 4409 | RSS: Main: 185425920 15:21:27 INFO - PID 4409 | 15:21:29 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46996/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:30 INFO - PID 4409 | RSS: Main: 185286656 15:21:30 INFO - PID 4409 | 15:21:33 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46996/tests/kraken/driver.html?testName=audio-dft) 15:21:33 INFO - PID 4409 | RSS: Main: 185376768 15:21:33 INFO - PID 4409 | 15:21:37 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46996/tests/kraken/driver.html?testName=audio-fft) 15:21:37 INFO - PID 4409 | RSS: Main: 181682176 15:21:37 INFO - PID 4409 | 15:21:39 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46996/tests/kraken/driver.html?testName=audio-oscillator) 15:21:40 INFO - PID 4409 | RSS: Main: 181882880 15:21:40 INFO - PID 4409 | 15:21:42 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46996/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:43 INFO - PID 4409 | RSS: Main: 182407168 15:21:43 INFO - PID 4409 | 15:21:46 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46996/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:47 INFO - PID 4409 | RSS: Main: 183009280 15:21:47 INFO - PID 4409 | 15:21:50 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46996/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:51 INFO - PID 4409 | RSS: Main: 183681024 15:21:51 INFO - PID 4409 | 15:21:54 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46996/tests/kraken/driver.html?testName=json-parse-financial) 15:21:55 INFO - PID 4409 | RSS: Main: 184000512 15:21:55 INFO - PID 4409 | 15:21:56 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46996/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:57 INFO - PID 4409 | RSS: Main: 183369728 15:21:57 INFO - PID 4409 | 15:21:58 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:59 INFO - PID 4409 | RSS: Main: 183877632 15:21:59 INFO - PID 4409 | 15:22:01 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:02 INFO - PID 4409 | RSS: Main: 184393728 15:22:02 INFO - PID 4409 | 15:22:05 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:05 INFO - PID 4409 | RSS: Main: 185864192 15:22:05 INFO - PID 4409 | 15:22:08 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:09 INFO - PID 4409 | RSS: Main: 185024512 15:22:09 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | Cycle 1(1): loaded http://localhost:46996/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46996/tests/kraken/driver.html?testName=ai-astar) 15:22:11 INFO - PID 4409 | RSS: Main: 186003456 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | __start_tp_report 15:22:11 INFO - PID 4409 | _x_x_mozilla_page_load 15:22:11 INFO - PID 4409 | _x_x_mozilla_page_load_details 15:22:11 INFO - PID 4409 | |i|pagename|runs| 15:22:11 INFO - PID 4409 | |0;ai-astar;113;114;114;110;115;107;114;108;111;111 15:22:11 INFO - PID 4409 | |1;audio-beat-detection;126;129;118;124;122;147;125;118;144;124 15:22:11 INFO - PID 4409 | |2;audio-dft;166;169;164;163;172;171;178;167;166;171 15:22:11 INFO - PID 4409 | |3;audio-fft;74;78;78;75;73;74;81;81;76;83 15:22:11 INFO - PID 4409 | |4;audio-oscillator;85;88;86;86;83;79;84;78;89;87 15:22:11 INFO - PID 4409 | |5;imaging-gaussian-blur;115;115;120;119;115;121;115;114;115;115 15:22:11 INFO - PID 4409 | |6;imaging-darkroom;152;150;148;149;149;149;149;150;151;153 15:22:11 INFO - PID 4409 | |7;imaging-desaturate;97;95;94;94;99;95;93;95;98;95 15:22:11 INFO - PID 4409 | |8;json-parse-financial;62;56;55;58;53;53;53;53;58;54 15:22:11 INFO - PID 4409 | |9;json-stringify-tinderbox;44;38;39;38;39;38;40;38;41;39 15:22:11 INFO - PID 4409 | |10;stanford-crypto-aes;78;73;81;77;76;75;75;84;77;76 15:22:11 INFO - PID 4409 | |11;stanford-crypto-ccm;124;120;112;116;117;112;119;123;129;120 15:22:11 INFO - PID 4409 | |12;stanford-crypto-pbkdf2;172;170;169;178;178;170;168;171;169;177 15:22:11 INFO - PID 4409 | |13;stanford-crypto-sha256-iterative;74;66;66;64;67;72;64;67;67;69 15:22:11 INFO - PID 4409 | __end_tp_report 15:22:11 INFO - PID 4409 | __start_cc_report 15:22:11 INFO - PID 4409 | _x_x_mozilla_cycle_collect,762 15:22:11 INFO - PID 4409 | __end_cc_report 15:22:11 INFO - PID 4409 | __startTimestamp1505859731334__endTimestamp 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | ------- Summary: start ------- 15:22:11 INFO - PID 4409 | Number of tests: 14 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:2.75 (2.4%) stddev-sans-first:2.88 15:22:11 INFO - PID 4409 | Values: 113.0 114.0 114.0 110.0 115.0 107.0 114.0 108.0 111.0 111.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:125.50 stddev:9.99 (8.0%) stddev-sans-first:10.58 15:22:11 INFO - PID 4409 | Values: 126.0 129.0 118.0 124.0 122.0 147.0 125.0 118.0 144.0 124.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#2] audio-dft Cycles:10 Average:168.70 Median:170.00 stddev:4.47 (2.6%) stddev-sans-first:4.64 15:22:11 INFO - PID 4409 | Values: 166.0 169.0 164.0 163.0 172.0 171.0 178.0 167.0 166.0 171.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#3] audio-fft Cycles:10 Average:77.30 Median:78.00 stddev:3.47 (4.4%) stddev-sans-first:3.46 15:22:11 INFO - PID 4409 | Values: 74.0 78.0 78.0 75.0 73.0 74.0 81.0 81.0 76.0 83.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:86.00 stddev:3.63 (4.2%) stddev-sans-first:3.84 15:22:11 INFO - PID 4409 | Values: 85.0 88.0 86.0 86.0 83.0 79.0 84.0 78.0 89.0 87.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:115.00 stddev:2.55 (2.2%) stddev-sans-first:2.65 15:22:11 INFO - PID 4409 | Values: 115.0 115.0 120.0 119.0 115.0 121.0 115.0 114.0 115.0 115.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.56 (1.0%) stddev-sans-first:1.48 15:22:11 INFO - PID 4409 | Values: 152.0 150.0 148.0 149.0 149.0 149.0 149.0 150.0 151.0 153.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.90 (2.0%) stddev-sans-first:1.94 15:22:11 INFO - PID 4409 | Values: 97.0 95.0 94.0 94.0 99.0 95.0 93.0 95.0 98.0 95.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:3.03 (5.5%) stddev-sans-first:2.11 15:22:11 INFO - PID 4409 | Values: 62.0 56.0 55.0 58.0 53.0 53.0 53.0 53.0 58.0 54.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.00 stddev:1.90 (4.9%) stddev-sans-first:1.05 15:22:11 INFO - PID 4409 | Values: 44.0 38.0 39.0 38.0 39.0 38.0 40.0 38.0 41.0 39.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:3.19 (4.1%) stddev-sans-first:3.37 15:22:11 INFO - PID 4409 | Values: 78.0 73.0 81.0 77.0 76.0 75.0 75.0 84.0 77.0 76.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.00 stddev:5.31 (4.4%) stddev-sans-first:5.34 15:22:11 INFO - PID 4409 | Values: 124.0 120.0 112.0 116.0 117.0 112.0 119.0 123.0 129.0 120.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:171.50 stddev:3.94 (2.3%) stddev-sans-first:4.18 15:22:11 INFO - PID 4409 | Values: 172.0 170.0 169.0 178.0 178.0 170.0 168.0 171.0 169.0 177.0 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:3.24 (4.8%) stddev-sans-first:2.47 15:22:11 INFO - PID 4409 | Values: 74.0 66.0 66.0 64.0 67.0 72.0 64.0 67.0 67.0 69.0 15:22:11 INFO - PID 4409 | -------- Summary: end -------- 15:22:11 INFO - PID 4409 | 15:22:11 INFO - PID 4409 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:22:12 INFO - TEST-INFO | 4409: exit 0 15:22:12 INFO - TEST-OK | kraken | took 63512ms 15:22:12 INFO - SUITE-END | took 1178s 15:22:12 INFO - Completed test suite (00:19:39) 15:22:12 INFO - javascript benchmark 15:22:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8465.440216223567, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.953365699514, 3124.9843750781242, 3157.352742687749, 3160.3679264147167, 3161.336119414923, 6174.259088909326, 6241.500679945605, 6262.561620686548, 6302.432781049704, 6364.363563643633, 6120.296165940918, 6189.566730328879, 6208.968955155218, 6210.223722034746, 6234.438900498954, 5665.716714164275, 5720.599558030939, 5724.656520608756, 5730.79942202023, 5731.340895796974, 5774.422557744234, 5837.5913686041995, 5867.442592953663, 5873.70631468427, 5905.970470147643, 5765.625234359753, 5814.941850581482, 5828.970855145718, 5830.533557315426, 5866.76532938682, 969.6884822105194, 5600.103983362683, 5652.3217213934595, 5757.798477053304, 5824.126381042856, 5186.247994040843, 5639.520640745542, 5734.340550836624, 5737.713114344266, 5750.683712395817, 6049.939500604982, 6209.820134174538, 6220.502359811204, 6269.529785266123, 6300.527460440485, 6637.46900247979, 6642.468602511835, 6660.800175994728, 6729.966350168218, 6731.0, 6702.497312701566, 6722.092517510123, 6799.11611490508, 6805.48958828085, 6807.5575087619145, 6205.565610407273, 6232.283287421914, 6244.87510249797, 6280.717367718464, 6302.46429053531, 6752.0, 6847.144106986627, 6878.58728476293, 6898.413634840995, 6903.6203008835, 6482.319356467598, 6542.967285163639, 6576.309487503743, 6583.80248592543, 6589.4069533742195, 6572.178477690289, 6671.066050752898, 6684.431823294977, 6696.665166741741, 6755.831104222336, 6645.534812563171, 6646.634435106019, 6707.6981535831, 6730.0, 6749.966250168816, 6512.706928188243, 6670.7665231716655, 6714.798556043326, 6750.527463077636, 6760.323967603299, 5164.586833053347, 5259.132243179909, 5297.867553311121, 5299.364076310867, 5308.0, 4635.490096089427, 4639.744814035261, 4649.395578574764, 4667.229907065296, 4697.13103075932, 5737.282839645044, 5795.1017592273265, 5826.213461182686, 5826.650400975955, 5828.125781132864, 6661.26726060133, 6725.9663701681175, 6758.256591774901, 6828.556143850634, 6848.657567121624, 5565.7217139143695, 5657.151427285858, 5664.348599910981, 5690.4025077367105, 5691.886162276731, 5453.754581043862, 5455.399906010336, 5468.699221542854, 5475.151351540518, 5480.725963701799, 6351.491880649537, 6368.076628888785, 6392.360763923571, 6461.61230326182, 6476.546641735127, 6738.932610673831, 6747.797566073025, 6760.459163267025, 6808.62552559614, 6831.487638427038, 6399.232092148972, 6465.0, 6483.124778154889, 6531.085648009187, 6546.738130474728, 6501.187351581052, 6595.934040659724, 6635.4359879410795, 6641.203055633355, 6642.800715978528, 6661.533692641468, 6695.296993815579, 6733.225679046972, 6734.562253453706, 6745.494087943522, 6452.903206451813, 6453.967730161319, 6457.096006558992, 6478.093066970534, 6490.837729056811, 6430.324815894263, 6475.222973243241, 6515.413612774873, 6537.934620653923, 6562.737490500326, 6283.59156654816, 6323.494120470259, 6405.0, 6476.060971159061, 6508.576942498722, 6541.574797638138, 6588.044733513518, 6614.933850661432, 6624.337566243337, 6632.933670663231, 6355.586886852339, 6370.203724534434, 6389.393007664265, 6427.421532062137, 6483.027545868157], "value": 6051.247926904556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.9366297527686, 862.3144600042965, 865.7489328094853, 870.30810505648, 874.0822136756404, 37229.25541489172, 40779.59220407795, 41193.0, 41237.38143927843, 41451.79274103629, 38005.61994380056, 38361.23277534448, 38482.230355392945, 38657.80671096648, 38663.806680966554, 7217.314355136254, 7277.381422579061, 7313.56118632881, 7317.890231646503, 7334.889976650355, 7865.488743231672, 8047.597620118971, 8076.555789431579, 8082.838343233132, 8087.919120808775, 8010.239027292427, 8025.879611805827, 8048.034235891701, 8090.110087890327, 8102.270795628392, 7846.686132554691, 7932.643031063616, 7984.640691168882, 8082.515049097073, 8107.756767296991, 7891.408144389194, 7969.322607578363, 7979.840403191962, 7983.72056978003, 7985.720499782537, 37889.621103788886, 38404.615953840665, 38457.23085538274, 38551.61448385508, 38579.80710096432, 3520.2431477232517, 3529.2412131391875, 3532.8056956867363, 3532.9646703532894, 3552.626974167701, 31104.533431998538, 31473.685263147305, 31587.52618710721, 31635.0, 31767.682323176705, 5218.921716174261, 5221.503957124067, 5249.947500524984, 5283.445238250005, 5327.920081198785, 173880.0, 174063.0, 174706.0, 175036.0, 175900.0, 40763.79618101891, 47380.289295660594, 47580.28629570559, 47628.28557571639, 47655.046899062516, 43584.78207608942, 43604.0, 50208.0, 51163.48836511662, 51375.48624513782, 16162.515124546282, 16394.26225819817, 16399.83600163983, 16548.172591370385, 16581.419650312182, 13448.596542103753, 13514.189148651112, 13519.324033798272, 13544.661383465493, 13583.796243056362, 14348.06737562055, 14385.64035899111, 14385.85614143866, 14402.855971440362, 14578.85421145775, 5690.459406356389, 5716.857078573069, 5767.971814797181, 5842.620229685142, 5901.527877769769, 976.0673865745721, 998.8901220865699, 1002.834532302162, 1013.1135256650431, 1016.0956748493846, 22401.887990559942, 22437.21469748551, 22637.094516219167, 22746.886265568897, 22817.657735133987, 1093.436880006797, 1108.4070022538065, 1114.1365441782684, 1115.8214685650257, 1127.2729089737074, 11854.407279635983, 12045.156839021185, 12050.216735912138, 12138.514459421523, 12206.267623942593, 216253.0, 217376.0, 218928.0, 220024.0, 220179.0, 51079.744601276754, 51266.23100653493, 51320.23019654708, 51514.74242628763, 51635.48364516382, 1400.7898815177805, 1459.1245252848207, 1460.3136525833054, 1473.5505670770517, 1480.3560451203762, 22196.0, 22678.319650410514, 22700.65949010799, 22707.659385108906, 22733.886330568243, 36506.26987460183, 36632.81683591672, 36798.080047999014, 36928.44607330838, 37089.62910370862, 181250.0, 181421.0, 181518.0, 182189.0, 182463.0, 29758.702412976458, 30446.695533044385, 30722.846385767927, 33744.15639609029, 35610.82194589011, 41432.3785143217, 43435.56564434442, 43789.34315985326, 43951.560484396025, 44150.0, 31947.520787188674, 32473.188170294987, 32517.0, 32571.837140814143, 32782.34435311328, 31076.0, 31293.194943420607, 31372.529412059295, 31875.84062079675, 32099.35801284008, 35757.46363804597, 35927.461088083175, 35990.0, 36030.8198459006, 36043.27913441664, 30975.0, 30997.225069373446, 31356.529652055695, 31439.84280078585, 31472.0, 22943.196988105337, 23095.0, 23238.535229295656, 23541.17605883786, 23892.522149556564], "value": 16960.77389281088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1339909740807, 557.3395526301333, 566.6568738267265, 570.7403131575136, 583.6906439587019, 22220.88889555552, 22632.321030369094, 22751.203707870227, 22912.427189320275, 22931.082756689713, 23214.76785232147, 24433.144839930606, 24444.0, 24703.876480617615, 24815.875920620416, 6483.254425741029, 6610.338966103399, 6644.93355066448, 6649.667516624149, 6658.167729033871, 6295.118683384329, 6518.087467754518, 6554.606723596599, 6558.114654521626, 6597.2083349998065, 6519.413252807246, 6527.836804079889, 6553.606783593, 6556.836079098013, 6582.275949645536, 6507.544471886946, 6552.672366381686, 6571.57284776488, 6572.112764776742, 6579.539432239745, 5892.381299963485, 6058.848528786815, 6081.756729730805, 6084.209052823149, 6085.939140608626, 27262.5910611341, 27441.17676469709, 27578.862105689343, 27671.58492622612, 27803.58294625582, 2086.2072412483312, 2138.4119367173994, 2138.764735879052, 2140.3257973738378, 2140.593287275413, 18641.906790466095, 19241.61516769671, 19591.118399671905, 19632.901835490873, 19696.70454943177, 2363.2555744940287, 2407.903683852644, 2410.0239403041796, 2430.2466235467064, 2431.161249368965, 120242.39878800638, 125373.0, 128922.0, 134921.0, 136621.0, 14155.433782648784, 14314.498992535211, 14340.21128837924, 14481.927590362191, 14662.046966947328, 22776.088956441556, 22785.20251791179, 22798.65802012971, 22826.201082962016, 22893.542129157322, 9712.61149554024, 10166.0, 10225.48872556384, 10225.642102526375, 10308.587656493657, 9504.857427138599, 9545.188658964065, 9618.086281803218, 9684.75788105303, 9777.120059194707, 8808.471491710518, 8842.027376988526, 8995.55022248885, 9005.864912026325, 9166.908330916738, 2543.9491210175693, 2668.759811616925, 2715.2804506805714, 2722.333028408013, 2729.7406746359065, 940.5062342270363, 985.4727720669407, 988.0564061321421, 995.0845222395413, 996.9900300997042, 18762.906185468986, 18947.33684321042, 19083.713744293847, 19099.140538675794, 19644.607107857762, 1010.5553556435145, 1029.3206483720708, 1030.2685093583489, 1041.7916416716687, 1042.4891803016467, 10231.9488402559, 10567.947160264303, 10704.625338113128, 10734.78530429387, 10801.405922674328, 452399.0, 456913.0, 465610.0, 473511.0, 476002.0, 109100.0, 111970.44014779874, 114409.0, 115800.0, 120813.39593302153, 1026.9897301027042, 1131.6095946898306, 1150.1546363423045, 1191.6365508519984, 1192.5170306026073, 19675.31136410219, 19678.90160549188, 19761.70357444668, 20271.0, 20341.898290509045, 53910.730446347516, 55016.0, 56014.71992640011, 56931.43068569261, 57601.135982961125, 70032.0, 70073.0, 70119.64940175267, 70331.64834176001, 70529.58940821052, 13069.477220911058, 13262.27057511846, 13282.86717132855, 13304.46782128704, 13517.188968661912, 22138.33584992453, 22320.77679223187, 22373.216937407113, 22429.887850560644, 22618.321450356514, 17491.300347986446, 18217.726734098735, 18255.0, 18274.90862545679, 18323.90838045801, 15575.0, 16205.59486012859, 16486.917565412095, 16652.417165399154, 16799.0, 17972.730409044136, 18162.909185453987, 18184.181711823265, 18523.90738046301, 18781.34265300708, 13157.868421315665, 13187.934060329637, 13214.603561893158, 13288.534901278408, 13419.194848309133, 17757.911210443865, 17778.199981000627, 17926.462206133838, 17966.910165449088, 18156.72764908501], "value": 11770.789978325976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.6002239305815, 1343.9596812095629, 1354.2416246901735, 1356.8914486841054, 1357.6198664373967, 13995.999999999987, 14461.783073253897, 14580.125192488458, 14656.926715366435, 14675.0, 14314.928425357884, 14437.63905902353, 14509.274536273171, 14514.0, 14514.201718905457, 2673.6925253595796, 2755.6830964439046, 2777.791665625076, 2778.597103420003, 2779.291280723413, 2654.86725663717, 2697.9190624281305, 2745.2450576091533, 2745.9725402746017, 2747.835129892213, 2539.7841183499427, 2669.546177149889, 2747.5603903375463, 2755.7657599104, 2758.8758505867186, 2666.4533770576986, 2670.2923725212836, 2692.407670312528, 2707.0795929384008, 2713.945721085567, 2576.0726138590094, 2620.7903367730537, 2621.934451638705, 2622.645942797736, 2661.188337557044, 14252.0, 14257.0, 14301.92849035748, 14341.641458963504, 14388.208648524327, 7520.8119797004965, 8061.193880611951, 8090.474119182234, 8169.468984515987, 8173.0, 5251.107311756972, 5522.199281104257, 5584.078627026536, 5585.581081418869, 5600.691961942091, 1835.3851459760997, 1857.5263307856546, 1862.4040307101732, 1905.2093381246766, 1917.8561607879326, 24226.515469690683, 24404.02383904642, 24433.144839930515, 24571.0, 24628.138015169385, 6487.572733998512, 6525.314841941527, 6538.901916471256, 6597.2742998271115, 6713.0266111413575, 16264.186790660657, 16280.674386512203, 16346.264418100976, 16410.507684769476, 16491.0, 7524.548527088392, 7764.417668674872, 7775.883361749578, 7803.180666030099, 7864.056313242333, 7198.748043818546, 7252.891206631904, 7339.339459448675, 7382.852342953111, 7399.149097853708, 4934.4572097069295, 5071.340725705634, 5147.510986456281, 5149.794008239628, 5209.583233341324, 1302.9674258143432, 1487.278669845146, 1490.8967364150667, 1491.7469325766192, 1517.1352329172266, 742.5693098003145, 873.0352959979132, 890.0832142892831, 895.91936725695, 908.3142227618106, 7216.9278307216255, 7302.780916572405, 7308.96345518269, 7324.2309557496765, 7346.595937223504, 975.1759763000254, 1010.7271036820017, 1013.9391636501833, 1014.6043043213152, 1022.994885025585, 4468.977655111768, 4531.77341132942, 4581.496035436099, 4593.379893714373, 4637.582617564435, 19850.90074549618, 19933.302334418226, 20060.799392006185, 20199.899000505196, 20384.694229586567, 19469.707954380694, 20114.597708045756, 20310.593788124155, 20328.0, 20415.285465008652, 10321.071103600712, 10468.0, 10580.52387642558, 10582.100521455763, 10621.787564248672, 8035.236652518001, 8064.0, 8106.47307924983, 8151.714689985822, 8182.795430114056, 17572.91213543924, 17828.821711782715, 17921.551961201076, 18043.729344059586, 18296.359627412978, 17832.19755110997, 17905.731414029062, 18251.269949201884, 18507.537311567317, 18630.161642725838, 10277.486125693536, 10373.688789336333, 10520.105791007543, 10550.0, 10553.841692374774, 12929.935350323565, 13115.540956066492, 13138.540151094665, 13249.735005300034, 13252.20486770797, 10772.622958196425, 10977.945110274717, 11036.0, 11042.723931901766, 11047.779044419227, 10228.07947284748, 10292.433916134685, 10512.842307365243, 10535.578576857146, 10567.577296908345, 9380.827396575429, 9405.905940940504, 9612.375195612543, 9649.228061755182, 9663.371880827724, 7216.855662886608, 7411.110666720028, 7451.850962980819, 7490.550566966, 7522.134954480086, 6881.13985751781, 7055.894161587683, 7065.116860392451, 7209.4592905533345, 7296.927030729625], "value": 6444.348892226394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.7194427232206, 515.9380874295084, 516.8139469790875, 522.6785526900954, 524.6773234460808, 6324.494040476762, 6403.263624683163, 6405.743770249196, 6415.781001609691, 6442.162518872546, 6248.500119990401, 6289.49684025278, 6357.777477788279, 6369.299377068519, 6382.553221274513, 5231.398389185245, 5284.497972692608, 5301.787928482856, 5301.946980530203, 5324.387695415019, 5234.7120908350025, 5236.659617124894, 5263.210518422248, 5264.894702105956, 5326.227696983935, 4892.315075889378, 5075.340205773263, 5075.5178258065425, 5081.517255860687, 5092.0, 5034.647574669774, 5075.0, 5081.085404627165, 5095.847124586268, 5132.769025393847, 4530.207213737583, 4538.523455037207, 4567.2920697291975, 4569.817207311737, 4577.29051996941, 5998.8500287492725, 6149.692515374213, 6156.599821011665, 6266.717997690115, 6270.623762574214, 5704.258446401941, 5749.3388260350175, 5793.797217097382, 5816.8947899898885, 5841.88316233673, 6604.240512341046, 6607.80176594703, 6644.069830223772, 6652.0, 6714.971017389576, 4948.6288528360155, 4954.554090131869, 4964.453910069889, 4974.980129073568, 4976.4525902150735, 6596.472282217411, 6882.621455819978, 6917.169939607229, 6995.79012629622, 7023.719051237893, 5513.173024046345, 5533.114701647797, 5554.888902222014, 5573.164025396223, 5597.524210442077, 5587.776488940478, 5626.2967129108865, 5666.603337766399, 5685.403032681592, 5711.514521265739, 6049.425304596057, 6059.394060593993, 6095.116208149882, 6106.267247930188, 6130.325664176937, 6647.468202543785, 6709.19489661234, 6739.393454589111, 6788.796336109925, 6823.249442561314, 1965.4889728670362, 1968.6161198566429, 1970.7930667280016, 1976.3478052242726, 1990.8705934114237, 1359.7212571422835, 1446.3491428857055, 1448.304813689414, 1451.978220326696, 1474.8303945046243, 5752.884942301214, 5760.185541554397, 5782.566307526952, 5804.477597016289, 5830.941690583039, 6720.7647732330115, 6757.256701762803, 6779.389854912983, 6806.251312355637, 6850.554713943578, 5646.2942132233475, 5705.4579814917515, 5714.714264286769, 5753.539716822728, 5789.536837053026, 3580.409232476612, 3605.351036813399, 3632.6398081774782, 3634.473001414833, 3640.28906413985, 6482.902756458657, 6496.285408605049, 6500.317466666026, 6543.1821022372205, 6601.768938087144, 7017.228104908456, 7033.402160816286, 7047.0452467664745, 7067.293270672892, 7088.3974862136265, 6508.739650414025, 6557.082008518812, 6557.311482294386, 6560.639164845979, 6649.268580456146, 6769.323067693388, 6771.695273712597, 6861.691223894837, 6906.102206713095, 6908.723651053901, 6693.698783554654, 6737.696803643946, 6761.667224807434, 6781.966090169518, 6838.213605435439, 6389.594289256356, 6431.646259455775, 6491.156149700509, 6498.642574658439, 6511.21865376139, 5479.643823151482, 5485.177223416519, 5525.696086715269, 5526.143447765603, 5555.472230138131, 6504.0243963405865, 6527.379898909596, 6635.867282654416, 6718.596884186964, 6729.5625784323865, 6553.869992252632, 6557.344265573595, 6593.835154121185, 6611.438027767501, 6638.601683898982, 6428.935710642833, 6434.0, 6497.9025314619375, 6560.442362399059, 6582.1443212384, 6241.875162496815, 6438.9697648377905, 6469.417752402306, 6501.6099034056215, 6516.152900122954, 6571.34286571339, 6583.703733331916, 6611.966940165268, 6615.702293396713, 6717.731290748316, 6404.775832845828, 6452.193475815523, 6473.838154046187, 6494.155759751202, 6532.8366790830605], "value": 5208.788459243806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.3361845852528, 912.0560220172123, 915.0346384564282, 927.1099744245524, 938.4932136646212, 18653.72019419708, 19117.330893418733, 19182.712259316122, 19224.71162932557, 19319.13063912124, 17003.149842507886, 17138.828611713878, 17141.400050998218, 17445.912770436164, 17537.912310438463, 947.322664295029, 948.4972964328916, 951.8572214167896, 955.1499165742495, 958.3818437108096, 967.9516024198762, 976.9658061967832, 979.7158823941048, 985.8028394321165, 986.7878406142678, 972.3436680240844, 1013.2856336282903, 1019.1031891935087, 1020.5203554329453, 1024.938503689781, 1017.64382466137, 1018.9898101018969, 1019.2966852871494, 1021.1677482851527, 1021.5658345203259, 726.1902978179291, 745.7054463486946, 750.2422553221231, 753.868073087213, 755.1278273593953, 19390.515237119045, 19783.80216197834, 19788.604227915363, 19809.9009504953, 19845.9007704962, 21233.25683601082, 21350.0, 21915.452113697127, 22111.668324975137, 22130.88934555317, 16485.17574121301, 16692.415765448273, 16762.161891905478, 16875.409360672442, 16933.745993810102, 3717.9070523237137, 3739.925201495982, 3743.2513497300647, 3752.3620984432714, 3755.455458958463, 106034.0, 129784.0, 130398.3480082603, 139471.0, 142431.28784356115, 17333.133343333036, 17568.648627027644, 17796.3771268005, 17918.820811791975, 17963.281468741367, 31516.684833151834, 31527.84236078805, 31985.68014319827, 32113.51829722556, 32274.515882261785, 8877.422967507091, 9094.772630684154, 9105.317101217435, 9122.498262595622, 9144.81710365789, 4209.431726716915, 4250.36244563318, 4267.3598960155605, 4273.1026484438, 4283.0, 5388.191771234347, 5481.588880833953, 5482.068048431776, 5485.122380419114, 5494.835154945358, 1031.0771859186136, 1069.2675517270695, 1071.4160782373624, 1072.1101485766794, 1085.9239853210358, 624.5815303746501, 642.9935700643027, 659.5679829711546, 662.0730976632752, 663.9502037347219, 11366.374849383197, 11692.649220523397, 11838.099665581987, 11883.0, 12107.39463026845, 632.1623848400887, 636.8630744389978, 646.7186773753432, 649.694643517546, 657.1686816177539, 5795.971020144872, 5797.710114494258, 5826.271716035496, 5930.140129681172, 5945.40545945402, 124345.0, 124444.0, 125470.0, 125483.0, 127504.36247818702, 86417.56791216004, 98525.50737246269, 106272.37199113863, 108552.0, 108749.0, 88591.11408885957, 89088.0, 90001.0, 90853.0, 91568.08431915595, 12774.936125319315, 13189.934050329686, 13309.933450332686, 13361.13152645075, 13399.0, 41500.169996599296, 42285.788571056946, 42352.0, 43073.569264306956, 43301.3504797422, 55748.44251557432, 56109.15836262541, 56110.0, 57063.14405283841, 58225.70887145537, 18328.266869325078, 18490.722639160693, 18542.907285464025, 18610.906945465187, 18831.435056948314, 18944.905275473535, 19315.8068419314, 19393.612127757082, 19518.21927122899, 19672.409827705193, 18527.166277517812, 19018.23927042958, 19121.426357209308, 19351.709724353863, 19492.0, 14877.256137193313, 14977.400903964155, 14994.400223990919, 15036.173010484528, 15073.698526029637, 15815.68368632644, 15831.68336633284, 15932.522024339289, 16000.359985600911, 16016.679666406373, 12359.32023738667, 12438.256851497727, 12466.812997805222, 12526.561570344995, 12571.434285456993, 14400.495982640557, 14467.638309041937, 14507.709845802814, 14518.056326338754, 14583.92708036453], "value": 9075.28387726628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1462.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 110.0, 115.0, 107.0, 114.0, 108.0, 111.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 118.0, 124.0, 122.0, 147.0, 125.0, 118.0, 144.0, 124.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 164.0, 163.0, 172.0, 171.0, 178.0, 167.0, 166.0, 171.0], "value": 168.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 78.0, 75.0, 73.0, 74.0, 81.0, 81.0, 76.0, 83.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 86.0, 86.0, 83.0, 79.0, 84.0, 78.0, 89.0, 87.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 120.0, 119.0, 115.0, 121.0, 115.0, 114.0, 115.0, 115.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 148.0, 149.0, 149.0, 149.0, 149.0, 150.0, 151.0, 153.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 99.0, 95.0, 93.0, 95.0, 98.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 56.0, 55.0, 58.0, 53.0, 53.0, 53.0, 53.0, 58.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 38.0, 39.0, 38.0, 39.0, 38.0, 40.0, 38.0, 41.0, 39.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 81.0, 77.0, 76.0, 75.0, 75.0, 84.0, 77.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 112.0, 116.0, 117.0, 112.0, 119.0, 123.0, 129.0, 120.0], "value": 119.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 169.0, 178.0, 178.0, 170.0, 168.0, 171.0, 169.0, 177.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 66.0, 66.0, 64.0, 67.0, 72.0, 64.0, 67.0, 67.0, 69.0], "value": 67.6, "unit": "score"}]}]} 15:22:12 INFO - Return code: 0 15:22:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:22:12 INFO - # TBPL SUCCESS # 15:22:12 INFO - Running post-action listener: _package_coverage_data 15:22:12 INFO - Running post-action listener: _resource_record_post_action 15:22:12 INFO - [mozharness: 2017-09-19 22:22:12.625478Z] Finished run-tests step (success) 15:22:12 INFO - Running post-run listener: _resource_record_post_run 15:22:12 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 13488128; Write bytes: 340197376; Read time: 4888; Write time: 543732 15:22:12 INFO - TinderboxPrint: CPU usage
13.3% 15:22:12 INFO - TinderboxPrint: I/O read bytes / time
13,488,128 / 4,888 15:22:12 INFO - TinderboxPrint: I/O write bytes / time
340,197,376 / 543,732 15:22:12 INFO - TinderboxPrint: CPU idle
8,274.2 (86.7%) 15:22:12 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 15:22:12 INFO - TinderboxPrint: Swap in / out
0 / 0 15:22:12 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 68485120; Read time: 0; Write time: 77848 15:22:12 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:12 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 11354112; Write bytes: 234012672; Read time: 4024; Write time: 351620 15:22:13 INFO - Running post-run listener: _upload_blobber_files 15:22:13 INFO - Blob upload gear active. 15:22:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:13 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:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:13 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:14 INFO - (blobuploader) - INFO - Done attempting. 15:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:22:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:16 INFO - (blobuploader) - INFO - Done attempting. 15:22:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:22:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:22:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:17 INFO - (blobuploader) - INFO - Done attempting. 15:22:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: 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 - Iteration through files over. 15:22:24 INFO - Return code: 0 15:22:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd515da6143fb460b4dc669bb4199d1ef87c7e6ecea87f954338d4f453ef2617722277da7796b94be28d64f25136aa48c9947fd580d9997e0d6519cd6cd6fa3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716f51c2fefd97b7e80aa21f11219dd0afca3a6d481d2652a774c987b3ab4297e9bc33487d4eaff791a53093c07f983d6f71112b7b110584288b1c023a774fea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd90cc6a157fe7d0d2651e9650287debd8c7a517bb42ff2874cf96e8fd2581ddb84bece4d3fb7e8b85f985960697c6a8ebb704dc408ab2fdf098a6a503c2957", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ec5cc14cbcee103654ecac5adbabad9ed6f5f80d1401e446705df71953908ec758e951e961b1d1ca50c9b9059f805898371159fc451a408ab9d22634954516"} 15:22:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:24 INFO - Contents: 15:22:24 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd515da6143fb460b4dc669bb4199d1ef87c7e6ecea87f954338d4f453ef2617722277da7796b94be28d64f25136aa48c9947fd580d9997e0d6519cd6cd6fa3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716f51c2fefd97b7e80aa21f11219dd0afca3a6d481d2652a774c987b3ab4297e9bc33487d4eaff791a53093c07f983d6f71112b7b110584288b1c023a774fea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd90cc6a157fe7d0d2651e9650287debd8c7a517bb42ff2874cf96e8fd2581ddb84bece4d3fb7e8b85f985960697c6a8ebb704dc408ab2fdf098a6a503c2957", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ec5cc14cbcee103654ecac5adbabad9ed6f5f80d1401e446705df71953908ec758e951e961b1d1ca50c9b9059f805898371159fc451a408ab9d22634954516"} 15:22:24 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:24 INFO - Copying logs to upload dir... 15:22:24 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.269052 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-09-19 15:22:24.716386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:24.723856) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdd515da6143fb460b4dc669bb4199d1ef87c7e6ecea87f954338d4f453ef2617722277da7796b94be28d64f25136aa48c9947fd580d9997e0d6519cd6cd6fa3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716f51c2fefd97b7e80aa21f11219dd0afca3a6d481d2652a774c987b3ab4297e9bc33487d4eaff791a53093c07f983d6f71112b7b110584288b1c023a774fea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd90cc6a157fe7d0d2651e9650287debd8c7a517bb42ff2874cf96e8fd2581ddb84bece4d3fb7e8b85f985960697c6a8ebb704dc408ab2fdf098a6a503c2957", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ec5cc14cbcee103654ecac5adbabad9ed6f5f80d1401e446705df71953908ec758e951e961b1d1ca50c9b9059f805898371159fc451a408ab9d22634954516"} build_url:https://queue.taskcluster.net/v1/task/AyerD6BRQGKrCIFu0VWbgg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011648 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/sha512/cdd515da6143fb460b4dc669bb4199d1ef87c7e6ecea87f954338d4f453ef2617722277da7796b94be28d64f25136aa48c9947fd580d9997e0d6519cd6cd6fa3", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/716f51c2fefd97b7e80aa21f11219dd0afca3a6d481d2652a774c987b3ab4297e9bc33487d4eaff791a53093c07f983d6f71112b7b110584288b1c023a774fea", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd90cc6a157fe7d0d2651e9650287debd8c7a517bb42ff2874cf96e8fd2581ddb84bece4d3fb7e8b85f985960697c6a8ebb704dc408ab2fdf098a6a503c2957", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ec5cc14cbcee103654ecac5adbabad9ed6f5f80d1401e446705df71953908ec758e951e961b1d1ca50c9b9059f805898371159fc451a408ab9d22634954516"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:24.755348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:24.755699) ========= 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=ba164b0a7b0ec7655860e956000001c1-1505856564.392425-15024944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 15:22:24.835351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 15:22:24.838787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 15:22:24.839163) ========= ========= Total master_lag: 0.31 =========