builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1505759065.09 results: success (0) revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.091547) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.092140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.095017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.235927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.236252) ========= 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=41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 11:24: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.8M=0s 2017-09-18 11:24:25 (41.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084105 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.382346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.382738) ========= 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=41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014350 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:25.436736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-18 11:24:25.437083) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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=41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 11:24:25,492 truncating revision to first 12 chars 2017-09-18 11:24:25,493 Setting DEBUG logging. 2017-09-18 11:24:25,493 attempt 1/10 2017-09-18 11:24:25,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42151fcd6cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 11:24:26,347 unpacking tar archive at: mozilla-central-42151fcd6cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.165030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-18 11:24:26.623609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.623903) ========= script_repo_revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.624258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.628622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:24:26.658821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-18 11:24:26.659214) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:26 INFO - MultiFileLogger online at 20170918 11:24:26 in /builds/slave/test 11:24:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:24:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:26 INFO - {'append_to_log': False, 11:24:26 INFO - 'base_work_dir': '/builds/slave/test', 11:24:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:24:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:26 INFO - 'branch': 'Firefox-Non-PGO', 11:24:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:26 INFO - 'code_coverage': False, 11:24:26 INFO - 'config_files': ('talos/linux_config.py',), 11:24:26 INFO - 'default_actions': ('clobber', 11:24:26 INFO - 'read-buildbot-config', 11:24:26 INFO - 'download-and-extract', 11:24:26 INFO - 'populate-webroot', 11:24:26 INFO - 'create-virtualenv', 11:24:26 INFO - 'install', 11:24:26 INFO - 'setup-mitmproxy', 11:24:26 INFO - 'run-tests'), 11:24:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:26 INFO - 'disable_ccov_upload': False, 11:24:26 INFO - 'disable_stylo': False, 11:24:26 INFO - 'download_minidump_stackwalk': True, 11:24:26 INFO - 'download_symbols': 'ondemand', 11:24:26 INFO - 'enable_stylo': False, 11:24:26 INFO - 'enable_webrender': False, 11:24:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:24:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:26 INFO - 'gecko_profile': False, 11:24:26 INFO - 'gecko_profile_interval': 0, 11:24:26 INFO - 'installer_path': 'installer.exe', 11:24:26 INFO - 'log_level': 'info', 11:24:26 INFO - 'log_name': 'talos', 11:24:26 INFO - 'log_to_console': True, 11:24:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:26 INFO - 'opt_config_files': (), 11:24:26 INFO - 'pip_index': False, 11:24:26 INFO - 'suite': 'dromaeojs-e10s', 11:24:26 INFO - 'system_bits': '32', 11:24:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:26 INFO - 'title': 'talos-linux64-ix-026', 11:24:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:26 INFO - 'use_talos_json': True, 11:24:26 INFO - 'verify': 'False', 11:24:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:26 INFO - 'work_dir': 'build'} 11:24:26 INFO - [mozharness: 2017-09-18 18:24:26.850816Z] Running clobber step. 11:24:26 INFO - Running pre-action listener: _resource_record_pre_action 11:24:26 INFO - Running main action method: clobber 11:24:26 INFO - rmtree: /builds/slave/test/build 11:24:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:28 INFO - Running post-action listener: _resource_record_post_action 11:24:28 INFO - [mozharness: 2017-09-18 18:24:28.356703Z] Finished clobber step (success) 11:24:28 INFO - [mozharness: 2017-09-18 18:24:28.356801Z] Running read-buildbot-config step. 11:24:28 INFO - Running pre-action listener: _resource_record_pre_action 11:24:28 INFO - Running main action method: read_buildbot_config 11:24:28 INFO - Using buildbot properties: 11:24:28 INFO - { 11:24:28 INFO - "project": "", 11:24:28 INFO - "product": "firefox", 11:24:28 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:24:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:24:28 INFO - "stage_platform": "linux64", 11:24:28 INFO - "basedir": "/builds/slave/test", 11:24:28 INFO - "buildnumber": 845, 11:24:28 INFO - "platform": "ubuntu64_hw", 11:24:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:28 INFO - "slavebuilddir": "test", 11:24:28 INFO - "taskId": "FYva0UAPRraGh4o7E3Pang", 11:24:28 INFO - "branch": "mozilla-central", 11:24:28 INFO - "script_repo_revision": "production", 11:24:28 INFO - "revision": "42151fcd6cfc216d147730d0f2c6a2acd52d22fd", 11:24:28 INFO - "slavename": "talos-linux64-ix-026", 11:24:28 INFO - "repo_path": "mozilla-central" 11:24:28 INFO - } 11:24:28 INFO - Finding installer, test and symbols from parent task. 11:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FYva0UAPRraGh4o7E3Pang'}, attempt #1 11:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FYva0UAPRraGh4o7E3Pang'}, attempt #1 11:24:29 INFO - Task dependencies: SnPiQaAJQmqSN7jo34Jbdw 11:24:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw'}, attempt #1 11:24:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json 11:24:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip 11:24:29 INFO - Running post-action listener: _resource_record_post_action 11:24:29 INFO - [mozharness: 2017-09-18 18:24:29.680260Z] Finished read-buildbot-config step (success) 11:24:29 INFO - [mozharness: 2017-09-18 18:24:29.680476Z] Running download-and-extract step. 11:24:29 INFO - Running pre-action listener: _resource_record_pre_action 11:24:29 INFO - Running main action method: download_and_extract 11:24:29 INFO - mkdir: /builds/slave/test/build/tests 11:24: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')]} 11:24:29 INFO - trying https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json 11:24:29 INFO - Downloading https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:30 INFO - Downloaded 989 bytes. 11:24:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:30 INFO - Using the following test package requirements: 11:24:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:30 INFO - u'common': [u'target.common.tests.zip'], 11:24:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:30 INFO - u'target.web-platform.tests.tar.gz'], 11:24:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:24:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip 11:24:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:30 INFO - Fetch https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.common.tests.zip into memory 11:24:31 INFO - Content-Length response header: 54731144 11:24:31 INFO - Bytes received: 54731144 11:24:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip 11:24:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:42 INFO - Fetch https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.talos.tests.zip into memory 11:24:43 INFO - Content-Length response header: 14508748 11:24:43 INFO - Bytes received: 14508748 11:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:43 INFO - trying https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:44 INFO - Downloaded 61505247 bytes. 11:24:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:44 INFO - mkdir: /builds/slave/test/properties 11:24:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:44 INFO - Contents: 11:24:44 INFO - build_url:https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - Running post-action listener: find_tests_for_verification 11:24:44 INFO - Running post-action listener: set_extra_try_arguments 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.583751Z] Finished download-and-extract step (success) 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.583875Z] Running populate-webroot step. 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: populate_webroot 11:24:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tresize', 11:24:44 INFO - 'tcanvasmark']}, 11:24:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['dromaeo_css', 11:24:44 INFO - 'kraken']}, 11:24:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'tests': ['damp', 'tps']}, 11:24:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['damp', 'tps']}, 11:24:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['dromaeo_dom']}, 11:24:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['basic_compositor_video', 11:24:44 INFO - 'glvideo']}, 11:24:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['ts_paint_webext', 11:24:44 INFO - 'tp5o_webext']}, 11:24:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_many_windows', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['a11yr', 11:24:44 INFO - 'ts_paint', 11:24:44 INFO - 'tpaint', 11:24:44 INFO - 'sessionrestore', 11:24:44 INFO - 'sessionrestore_many_windows', 11:24:44 INFO - 'sessionrestore_no_auto_restore', 11:24:44 INFO - 'tabpaint']}, 11:24:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:24:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['perf_reftest_singletons']}, 11:24:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['bloom_basic']}, 11:24:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:44 INFO - 'tsvgr_opacity', 11:24:44 INFO - 'tart', 11:24:44 INFO - 'tscrollx', 11:24:44 INFO - 'tsvg_static']}, 11:24:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tsvgx', 11:24:44 INFO - 'tsvgr_opacity', 11:24:44 INFO - 'tart', 11:24:44 INFO - 'tscrollx', 11:24:44 INFO - 'tsvg_static']}, 11:24:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo'], 11:24:44 INFO - 'tests': ['tp5o']}, 11:24:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:44 INFO - 'talos_options': ['--mitmproxy', 11:24:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:44 INFO - '--firstNonBlankPaint'], 11:24:44 INFO - 'tests': ['tp6_google', 11:24:44 INFO - 'tp6_youtube', 11:24:44 INFO - 'tp6_amazon', 11:24:44 INFO - 'tp6_facebook']}, 11:24:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo', 11:24:44 INFO - '--mitmproxy', 11:24:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:44 INFO - '--firstNonBlankPaint'], 11:24:44 INFO - 'tests': ['tp6_google', 11:24:44 INFO - 'tp6_youtube', 11:24:44 INFO - 'tp6_amazon', 11:24:44 INFO - 'tp6_facebook']}, 11:24:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:44 INFO - 'talos_options': ['--stylo-threads=1', 11:24:44 INFO - '--mitmproxy', 11:24:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:44 INFO - '--firstNonBlankPaint'], 11:24:44 INFO - 'tests': ['tp6_google', 11:24:44 INFO - 'tp6_youtube', 11:24:44 INFO - 'tp6_amazon', 11:24:44 INFO - 'tp6_facebook']}, 11:24:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--xperf_path', 11:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:44 INFO - 'tests': ['tp5n']}, 11:24:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:44 INFO - 'talos_options': ['--disable-stylo', 11:24:44 INFO - '--xperf_path', 11:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:44 INFO - 'tests': ['tp5n']}}} 11:24:44 INFO - Running post-action listener: _resource_record_post_action 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.948210Z] Finished populate-webroot step (success) 11:24:44 INFO - [mozharness: 2017-09-18 18:24:44.948432Z] Running create-virtualenv step. 11:24:44 INFO - Running pre-action listener: _resource_record_pre_action 11:24:44 INFO - Running main action method: create_virtualenv 11:24:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:24:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:45 INFO - Installing pip...............done. 11:24:45 INFO - Return code: 0 11:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:45 INFO - Reading from file tmpfile_stdout 11:24:45 INFO - Output received: 11:24:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:24:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:45 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')]} 11:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:45 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')]} 11:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:45 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24:45 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 11:24:45 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 11:24:45 INFO - Using env: {'DISPLAY': ':0', 11:24:45 INFO - 'HOME': '/home/cltbld', 11:24:45 INFO - 'LANG': 'en_US.UTF-8', 11:24:45 INFO - 'LANGUAGE': 'en_US:en', 11:24:45 INFO - 'LOGNAME': 'cltbld', 11:24:45 INFO - 'MAIL': '/var/mail/cltbld', 11:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:45 INFO - 'MOZ_NO_REMOTE': '1', 11:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:45 INFO - 'NO_EM_RESTART': '1', 11:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:45 INFO - 'PWD': '/builds/slave/test', 11:24:45 INFO - 'SHELL': '/bin/bash', 11:24:45 INFO - 'SHLVL': '1', 11:24:45 INFO - 'TERM': 'linux', 11:24:45 INFO - 'TMOUT': '86400', 11:24:45 INFO - 'USER': 'cltbld', 11:24:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:46 INFO - '_': '/tools/buildbot/bin/python'} 11:24:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:24:47 INFO - Downloading/unpacking pip>=1.5 11:24:47 INFO - Running setup.py egg_info for package pip 11:24:47 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:47 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:47 INFO - Installing collected packages: pip 11:24:47 INFO - Found existing installation: pip 1.1 11:24:47 INFO - Uninstalling pip: 11:24:47 INFO - Successfully uninstalled pip 11:24:47 INFO - Running setup.py install for pip 11:24:47 INFO - warning: no files found matching 'pip/cacert.pem' 11:24:47 INFO - warning: no files found matching '*.html' under directory 'docs' 11:24:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:24:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:24:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Successfully installed pip 11:24:47 INFO - Cleaning up... 11:24:47 INFO - Return code: 0 11:24:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:47 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24:47 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 11:24:47 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 11:24:47 INFO - Using env: {'DISPLAY': ':0', 11:24:47 INFO - 'HOME': '/home/cltbld', 11:24:47 INFO - 'LANG': 'en_US.UTF-8', 11:24:47 INFO - 'LANGUAGE': 'en_US:en', 11:24:47 INFO - 'LOGNAME': 'cltbld', 11:24:47 INFO - 'MAIL': '/var/mail/cltbld', 11:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:47 INFO - 'MOZ_NO_REMOTE': '1', 11:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:47 INFO - 'NO_EM_RESTART': '1', 11:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:47 INFO - 'PWD': '/builds/slave/test', 11:24:47 INFO - 'SHELL': '/bin/bash', 11:24:47 INFO - 'SHLVL': '1', 11:24:47 INFO - 'TERM': 'linux', 11:24:47 INFO - 'TMOUT': '86400', 11:24:47 INFO - 'USER': 'cltbld', 11:24:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:47 INFO - '_': '/tools/buildbot/bin/python'} 11:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:47 INFO - Downloading/unpacking psutil>=3.1.1 11:24:47 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 11:24:47 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 11:24:47 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 11:24:47 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 11:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:48 INFO - Installing collected packages: psutil 11:24:48 INFO - Running setup.py install for psutil 11:24:48 INFO - building 'psutil._psutil_linux' extension 11:24:48 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 11:24:48 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 11:24:48 INFO - building 'psutil._psutil_posix' extension 11:24:48 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 11:24:49 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 11:24:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:49 INFO - Successfully installed psutil 11:24:49 INFO - Cleaning up... 11:24:49 INFO - Return code: 0 11:24:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:49 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')]} 11:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:49 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')]} 11:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:49 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24:49 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 11:24:49 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 11:24:49 INFO - Using env: {'DISPLAY': ':0', 11:24:49 INFO - 'HOME': '/home/cltbld', 11:24:49 INFO - 'LANG': 'en_US.UTF-8', 11:24:49 INFO - 'LANGUAGE': 'en_US:en', 11:24:49 INFO - 'LOGNAME': 'cltbld', 11:24:49 INFO - 'MAIL': '/var/mail/cltbld', 11:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:49 INFO - 'MOZ_NO_REMOTE': '1', 11:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:49 INFO - 'NO_EM_RESTART': '1', 11:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:49 INFO - 'PWD': '/builds/slave/test', 11:24:49 INFO - 'SHELL': '/bin/bash', 11:24:49 INFO - 'SHLVL': '1', 11:24:49 INFO - 'TERM': 'linux', 11:24:49 INFO - 'TMOUT': '86400', 11:24:49 INFO - 'USER': 'cltbld', 11:24:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:49 INFO - '_': '/tools/buildbot/bin/python'} 11:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:49 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 11:24:49 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 11:24:49 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 11:24:49 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 11:24:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:51 INFO - Installing collected packages: mozsystemmonitor 11:24:51 INFO - Running setup.py install for mozsystemmonitor 11:24:51 INFO - Successfully installed mozsystemmonitor 11:24:51 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24: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')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24: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', '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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:24: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 jsonschema==2.5.1 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:53 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 11:24:53 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 11:24:53 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 11:24:53 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 11:24:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:54 INFO - warning: no files found matching '*.txt' 11:24:54 INFO - no previously-included directories found matching 'build' 11:24:54 INFO - no previously-included directories found matching 'dist' 11:24:54 INFO - no previously-included directories found matching '.git*' 11:24:54 INFO - Installing collected packages: jsonschema, functools32 11:24:54 INFO - Running setup.py install for functools32 11:24:54 INFO - warning: no files found matching '*.txt' 11:24:54 INFO - no previously-included directories found matching 'build' 11:24:54 INFO - no previously-included directories found matching 'dist' 11:24:54 INFO - no previously-included directories found matching '.git*' 11:24:54 INFO - Successfully installed jsonschema functools32 11:24:54 INFO - Cleaning up... 11:24:54 INFO - Return code: 0 11:24:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:54 INFO - Cleaning up... 11:24:54 INFO - Return code: 0 11:24:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:54 INFO - Using env: {'DISPLAY': ':0', 11:24:54 INFO - 'HOME': '/home/cltbld', 11:24:54 INFO - 'LANG': 'en_US.UTF-8', 11:24:54 INFO - 'LANGUAGE': 'en_US:en', 11:24:54 INFO - 'LOGNAME': 'cltbld', 11:24:54 INFO - 'MAIL': '/var/mail/cltbld', 11:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:54 INFO - 'MOZ_NO_REMOTE': '1', 11:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:54 INFO - 'NO_EM_RESTART': '1', 11:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:54 INFO - 'PWD': '/builds/slave/test', 11:24:54 INFO - 'SHELL': '/bin/bash', 11:24:54 INFO - 'SHLVL': '1', 11:24:54 INFO - 'TERM': 'linux', 11:24:54 INFO - 'TMOUT': '86400', 11:24:54 INFO - 'USER': 'cltbld', 11:24:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:54 INFO - '_': '/tools/buildbot/bin/python'} 11:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:54 INFO - Downloading/unpacking blobuploader==1.2.4 11:24: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 11:24: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 11:24: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 11:24: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 11:24:55 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:55 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 11:24:55 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 11:24:55 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 11:24:55 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 11:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 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 11:24:56 INFO - Downloading docopt-0.6.1.tar.gz 11:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:56 INFO - Running setup.py install for blobuploader 11:24:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:56 INFO - Running setup.py install for requests 11:24:56 INFO - Running setup.py install for docopt 11:24:57 INFO - Successfully installed blobuploader requests docopt 11:24:57 INFO - Cleaning up... 11:24:57 INFO - Return code: 0 11:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:57 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:24:57 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 11:24:57 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 11:24:57 INFO - Using env: {'DISPLAY': ':0', 11:24:57 INFO - 'HOME': '/home/cltbld', 11:24:57 INFO - 'LANG': 'en_US.UTF-8', 11:24:57 INFO - 'LANGUAGE': 'en_US:en', 11:24:57 INFO - 'LOGNAME': 'cltbld', 11:24:57 INFO - 'MAIL': '/var/mail/cltbld', 11:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:57 INFO - 'MOZ_NO_REMOTE': '1', 11:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:57 INFO - 'NO_EM_RESTART': '1', 11:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:57 INFO - 'PWD': '/builds/slave/test', 11:24:57 INFO - 'SHELL': '/bin/bash', 11:24:57 INFO - 'SHLVL': '1', 11:24:57 INFO - 'TERM': 'linux', 11:24:57 INFO - 'TMOUT': '86400', 11:24:57 INFO - 'USER': 'cltbld', 11:24:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:57 INFO - '_': '/tools/buildbot/bin/python'} 11:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:57 INFO - Running setup.py (path:/tmp/pip-yBEl3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:57 INFO - Running setup.py (path:/tmp/pip-1SOMEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:57 INFO - Running setup.py (path:/tmp/pip-7hUSyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:57 INFO - Running setup.py (path:/tmp/pip-siO9Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:57 INFO - Running setup.py (path:/tmp/pip-VrTfLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:57 INFO - Running setup.py (path:/tmp/pip-ZlJEfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:57 INFO - Running setup.py (path:/tmp/pip-l3LY0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:57 INFO - Running setup.py (path:/tmp/pip-KaPmP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:57 INFO - Running setup.py (path:/tmp/pip-luFib_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:57 INFO - Running setup.py (path:/tmp/pip-qOLpom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:57 INFO - Running setup.py (path:/tmp/pip-jU4rcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:58 INFO - Running setup.py (path:/tmp/pip-FjXn54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:58 INFO - Running setup.py (path:/tmp/pip-qgkF3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:58 INFO - Running setup.py (path:/tmp/pip-MQ_BBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:58 INFO - Running setup.py (path:/tmp/pip-vaEZBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:58 INFO - Running setup.py (path:/tmp/pip-MyLrxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:58 INFO - Running setup.py (path:/tmp/pip-9VHQxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:58 INFO - Running setup.py install for manifestparser 11:24:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:58 INFO - Running setup.py install for mozcrash 11:24:58 INFO - Running setup.py install for mozdebug 11:24:58 INFO - Running setup.py install for mozdevice 11:24:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:58 INFO - Running setup.py install for mozfile 11:24:58 INFO - Running setup.py install for mozhttpd 11:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozinfo 11:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozInstall 11:24:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozleak 11:24:59 INFO - Running setup.py install for mozlog 11:24:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for moznetwork 11:24:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozprocess 11:24:59 INFO - Running setup.py install for mozprofile 11:24:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozrunner 11:24:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:59 INFO - Running setup.py install for mozscreenshot 11:25:00 INFO - Running setup.py install for moztest 11:25:00 INFO - Running setup.py install for mozversion 11:25:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:00 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:00 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:25:00 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 11:25:00 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 11:25:00 INFO - Using env: {'DISPLAY': ':0', 11:25:00 INFO - 'HOME': '/home/cltbld', 11:25:00 INFO - 'LANG': 'en_US.UTF-8', 11:25:00 INFO - 'LANGUAGE': 'en_US:en', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MAIL': '/var/mail/cltbld', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SHLVL': '1', 11:25:00 INFO - 'TERM': 'linux', 11:25:00 INFO - 'TMOUT': '86400', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:00 INFO - Running setup.py (path:/tmp/pip-uZ5tav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:00 INFO - Running setup.py (path:/tmp/pip-BT8NNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:00 INFO - Running setup.py (path:/tmp/pip-JWHUz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:00 INFO - Running setup.py (path:/tmp/pip-e0dFIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:00 INFO - Running setup.py (path:/tmp/pip-hoqBxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:00 INFO - Running setup.py (path:/tmp/pip-nSUMkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:00 INFO - Running setup.py (path:/tmp/pip-eHhSNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:00 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)) 11:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:00 INFO - Running setup.py (path:/tmp/pip-cWS9ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:01 INFO - Running setup.py (path:/tmp/pip-RD7fHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:01 INFO - Running setup.py (path:/tmp/pip-NEy9M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:01 INFO - Running setup.py (path:/tmp/pip-Yniygi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:01 INFO - Running setup.py (path:/tmp/pip-H5a_E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:01 INFO - Running setup.py (path:/tmp/pip-wphKKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:01 INFO - Running setup.py (path:/tmp/pip-qc_kv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:01 INFO - Running setup.py (path:/tmp/pip-rhF9pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:01 INFO - Running setup.py (path:/tmp/pip-1A7aof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:01 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)) 11:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:01 INFO - Running setup.py (path:/tmp/pip-RcPbTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 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)) 11:25:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:02 INFO - Downloading blessings-1.6.tar.gz 11:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:02 INFO - Installing collected packages: blessings 11:25:02 INFO - Running setup.py install for blessings 11:25:02 INFO - Successfully installed blessings 11:25:02 INFO - Cleaning up... 11:25:03 INFO - Return code: 0 11:25:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:03 INFO - Reading from file tmpfile_stdout 11:25:03 INFO - Current package versions: 11:25:03 INFO - argparse == 1.2.1 11:25:03 INFO - blessings == 1.6 11:25:03 INFO - blobuploader == 1.2.4 11:25:03 INFO - docopt == 0.6.1 11:25:03 INFO - functools32 == 3.2.3-2 11:25:03 INFO - jsonschema == 2.5.1 11:25:03 INFO - manifestparser == 1.1 11:25:03 INFO - mozInstall == 1.13 11:25:03 INFO - mozcrash == 1.0 11:25:03 INFO - mozdebug == 0.1 11:25:03 INFO - mozdevice == 0.51 11:25:03 INFO - mozfile == 1.2 11:25:03 INFO - mozhttpd == 0.7 11:25:03 INFO - mozinfo == 0.10 11:25:03 INFO - mozleak == 0.1 11:25:03 INFO - mozlog == 3.5 11:25:03 INFO - moznetwork == 0.27 11:25:03 INFO - mozprocess == 0.25 11:25:03 INFO - mozprofile == 0.28 11:25:03 INFO - mozrunner == 6.13 11:25:03 INFO - mozscreenshot == 0.1 11:25:03 INFO - mozsystemmonitor == 0.3 11:25:03 INFO - moztest == 0.8 11:25:03 INFO - mozversion == 1.4 11:25:03 INFO - psutil == 3.1.1 11:25:03 INFO - requests == 1.2.3 11:25:03 INFO - wsgiref == 0.1.2 11:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:03 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')]} 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:03 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')]} 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:03 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:25:03 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 11:25:03 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 11:25:03 INFO - Using env: {'DISPLAY': ':0', 11:25:03 INFO - 'HOME': '/home/cltbld', 11:25:03 INFO - 'LANG': 'en_US.UTF-8', 11:25:03 INFO - 'LANGUAGE': 'en_US:en', 11:25:03 INFO - 'LOGNAME': 'cltbld', 11:25:03 INFO - 'MAIL': '/var/mail/cltbld', 11:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:03 INFO - 'MOZ_NO_REMOTE': '1', 11:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:03 INFO - 'NO_EM_RESTART': '1', 11:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:03 INFO - 'PWD': '/builds/slave/test', 11:25:03 INFO - 'SHELL': '/bin/bash', 11:25:03 INFO - 'SHLVL': '1', 11:25:03 INFO - 'TERM': 'linux', 11:25:03 INFO - 'TMOUT': '86400', 11:25:03 INFO - 'USER': 'cltbld', 11:25:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:03 INFO - '_': '/tools/buildbot/bin/python'} 11:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 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)) 11:25:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:03 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 11:25:03 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 11:25:03 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 11:25:03 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 11:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:04 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)) 11:25:04 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)) 11:25:04 INFO - Installing collected packages: simplejson 11:25:04 INFO - Running setup.py install for simplejson 11:25:04 INFO - building 'simplejson._speedups' extension 11:25:04 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 11:25:05 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 11:25:05 INFO - Successfully installed simplejson 11:25:05 INFO - Cleaning up... 11:25:05 INFO - Return code: 0 11:25:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:05 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1736a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, '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': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', '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 11:25:05 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 11:25:05 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 11:25:05 INFO - Using env: {'DISPLAY': ':0', 11:25:05 INFO - 'HOME': '/home/cltbld', 11:25:05 INFO - 'LANG': 'en_US.UTF-8', 11:25:05 INFO - 'LANGUAGE': 'en_US:en', 11:25:05 INFO - 'LOGNAME': 'cltbld', 11:25:05 INFO - 'MAIL': '/var/mail/cltbld', 11:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:05 INFO - 'MOZ_NO_REMOTE': '1', 11:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:05 INFO - 'NO_EM_RESTART': '1', 11:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:05 INFO - 'PWD': '/builds/slave/test', 11:25:05 INFO - 'SHELL': '/bin/bash', 11:25:05 INFO - 'SHLVL': '1', 11:25:05 INFO - 'TERM': 'linux', 11:25:05 INFO - 'TMOUT': '86400', 11:25:05 INFO - 'USER': 'cltbld', 11:25:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:05 INFO - '_': '/tools/buildbot/bin/python'} 11:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:05 INFO - Cleaning up... 11:25:05 INFO - Return code: 0 11:25:05 INFO - Running post-action listener: _resource_record_post_action 11:25:05 INFO - Running post-action listener: _start_resource_monitoring 11:25:05 INFO - Starting resource monitoring. 11:25:05 INFO - [mozharness: 2017-09-18 18:25:05.928385Z] Finished create-virtualenv step (success) 11:25:05 INFO - [mozharness: 2017-09-18 18:25:05.928896Z] Running install step. 11:25:05 INFO - Running pre-action listener: _resource_record_pre_action 11:25:05 INFO - Running main action method: install 11:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:06 INFO - Reading from file tmpfile_stdout 11:25:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:06 INFO - Reading from file tmpfile_stdout 11:25:06 INFO - Output received: 11:25:06 INFO - Usage: mozinstall [options] installer 11:25:06 INFO - Options: 11:25:06 INFO - -h, --help show this help message and exit 11:25:06 INFO - -d DEST, --destination=DEST 11:25:06 INFO - Directory to install application into. [default: 11:25:06 INFO - "/builds/slave/test"] 11:25:06 INFO - --app=APP Application being installed. [default: firefox] 11:25:06 INFO - mkdir: /builds/slave/test/build/application 11:25:06 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'] 11:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:24 INFO - Reading from file tmpfile_stdout 11:25:24 INFO - Output received: 11:25:24 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:24 INFO - Running post-action listener: _resource_record_post_action 11:25:24 INFO - [mozharness: 2017-09-18 18:25:24.204388Z] Finished install step (success) 11:25:24 INFO - [mozharness: 2017-09-18 18:25:24.204639Z] Running setup-mitmproxy step. 11:25:24 INFO - Running pre-action listener: _resource_record_pre_action 11:25:24 INFO - Running main action method: setup_mitmproxy 11:25:24 INFO - Skipping: mitmproxy is not required 11:25:24 INFO - Running post-action listener: _resource_record_post_action 11:25:24 INFO - [mozharness: 2017-09-18 18:25:24.205763Z] Finished setup-mitmproxy step (success) 11:25:24 INFO - [mozharness: 2017-09-18 18:25:24.205981Z] Running run-tests step. 11:25:24 INFO - Running pre-action listener: _resource_record_pre_action 11:25:24 INFO - Running pre-action listener: _set_gcov_prefix 11:25:24 INFO - Running main action method: run_tests 11:25:24 WARNING - Try message not found. 11:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:24 INFO - Python 2.7.3 11:25:24 INFO - Return code: 0 11:25:24 INFO - grabbing minidump binary from tooltool 11:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:24 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 0x18dd090>, '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 0x18ddd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d7f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:24 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 11:25:24 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 11:25:24 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 11:25:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:24 INFO - Return code: 0 11:25:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:24 INFO - ENV: RUST_BACKTRACE is now full 11:25:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 11:25:24 INFO - Using env: {'DISPLAY': ':0', 11:25:24 INFO - 'HOME': '/home/cltbld', 11:25:24 INFO - 'LANG': 'en_US.UTF-8', 11:25:24 INFO - 'LANGUAGE': 'en_US:en', 11:25:24 INFO - 'LOGNAME': 'cltbld', 11:25:24 INFO - 'MAIL': '/var/mail/cltbld', 11:25:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:24 INFO - 'MOZ_NO_REMOTE': '1', 11:25:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:24 INFO - 'NO_EM_RESTART': '1', 11:25:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:24 INFO - 'PWD': '/builds/slave/test', 11:25:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:24 INFO - 'RUST_BACKTRACE': 'full', 11:25:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:24 INFO - 'SHELL': '/bin/bash', 11:25:24 INFO - 'SHLVL': '1', 11:25:24 INFO - 'TERM': 'linux', 11:25:24 INFO - 'TMOUT': '86400', 11:25:24 INFO - 'USER': 'cltbld', 11:25:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:24 INFO - '_': '/tools/buildbot/bin/python'} 11:25:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:25:24 INFO - mozversion application_buildid: 20170918173522 11:25:24 INFO - mozversion application_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:25:24 INFO - mozversion application_display_name: Nightly 11:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:24 INFO - mozversion application_name: Firefox 11:25:24 INFO - mozversion application_remotingname: firefox 11:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:24 INFO - mozversion application_vendor: Mozilla 11:25:24 INFO - mozversion application_version: 57.0a1 11:25:24 INFO - mozversion platform_buildid: 20170918173522 11:25:24 INFO - mozversion platform_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:24 INFO - mozversion platform_version: 57.0a1 11:25:24 INFO - using testdate: 1505759124 11:25:24 INFO - actual date: 1505759124 11:25:24 INFO - starting webserver on 'localhost:45735' 11:25:24 INFO - SUITE-START | Running 2 tests 11:25:24 INFO - TEST-START | dromaeo_css 11:25:24 INFO - Initialising browser for dromaeo_css test... 11:25:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45735/getInfo.html -profile /tmp/tmpdENHVJ/profile 11:25:24 INFO - TEST-INFO | started process 24664 (/builds/slave/test/build/application/firefox/firefox http://localhost:45735/getInfo.html) 11:25:29 INFO - TEST-INFO | 24664: exit 0 11:25:29 INFO - Browser initialized. 11:25:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:29 INFO - Using env: {'DISPLAY': ':0', 11:25:29 INFO - 'HOME': '/home/cltbld', 11:25:29 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:29 INFO - 'LANG': 'en_US.UTF-8', 11:25:29 INFO - 'LANGUAGE': 'en_US:en', 11:25:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:29 INFO - 'LOGNAME': 'cltbld', 11:25:29 INFO - 'MAIL': '/var/mail/cltbld', 11:25:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:29 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:29 INFO - 'MOZ_NO_REMOTE': '1', 11:25:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:29 INFO - 'NO_EM_RESTART': '1', 11:25:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:29 INFO - 'PWD': '/builds/slave/test', 11:25:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:29 INFO - 'RUST_BACKTRACE': 'full', 11:25:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:29 INFO - 'SHELL': '/bin/bash', 11:25:29 INFO - 'SHLVL': '1', 11:25:29 INFO - 'TERM': 'linux', 11:25:29 INFO - 'TMOUT': '86400', 11:25:29 INFO - 'USER': 'cltbld', 11:25:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:29 INFO - '_': '/tools/buildbot/bin/python'} 11:25:29 INFO - TEST-INFO | started process 24898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdENHVJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:30 INFO - PID 24898 | 11:25:30 INFO - PID 24898 | (/builds/slave/test/build/application/firefox/firefox:24947): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:30 INFO - PID 24898 | 11:25:41 INFO - PID 24898 | RSS: Main: 154206208 11:25:41 INFO - PID 24898 | 11:28:38 INFO - PID 24898 | Cycle 1(1): loaded http://localhost:45735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45735/tests/dromaeo/cssquery-ext.html) 11:28:39 INFO - PID 24898 | RSS: Main: 155090944 11:28:39 INFO - PID 24898 | 11:31:41 INFO - PID 24898 | Cycle 1(1): loaded http://localhost:45735/tests/dromaeo/cssquery-ext.html (next: http://localhost:45735/tests/dromaeo/cssquery-jquery.html) 11:31:42 INFO - PID 24898 | RSS: Main: 153690112 11:31:42 INFO - PID 24898 | 11:34:43 INFO - PID 24898 | Cycle 1(1): loaded http://localhost:45735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45735/tests/dromaeo/cssquery-mootools.html) 11:34:44 INFO - PID 24898 | RSS: Main: 157171712 11:34:44 INFO - PID 24898 | 11:37:46 INFO - PID 24898 | Cycle 1(1): loaded http://localhost:45735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45735/tests/dromaeo/cssquery-prototype.html) 11:37:46 INFO - PID 24898 | RSS: Main: 155398144 11:37:46 INFO - PID 24898 | 11:40:50 INFO - PID 24898 | Cycle 1(1): loaded http://localhost:45735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45735/tests/dromaeo/cssquery-yui.html) 11:40:50 INFO - PID 24898 | RSS: Main: 156061696 11:40:50 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | Cycle 1(1): loaded http://localhost:45735/tests/dromaeo/cssquery-yui.html (next: http://localhost:45735/tests/dromaeo/cssquery-dojo.html) 11:43:52 INFO - PID 24898 | RSS: Main: 159297536 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | __start_tp_report 11:43:52 INFO - PID 24898 | _x_x_mozilla_page_load 11:43:52 INFO - PID 24898 | _x_x_mozilla_page_load_details 11:43:52 INFO - PID 24898 | |i|pagename|runs| 11:43:52 INFO - PID 24898 | |0;dojo.html;3105.8912938047165;3161.7944833585816;3182.347618738159;3189.378071276101;3196.6483686794454;6174.6912654367325;6313.368663133684;6313.684315784215;6369.490440764739;6422.100905873182;6243.250809902806;6322.620642761438;6334.366563343663;6359.6184228946295;6389.840253993652;5884.2056322396575;5955.285365756094;5958.046712525997;5962.165296858454;5978.103284507315;5857.092150716646;5882.499987501067;5910.320313163977;5969.22400087988;5984.5511586630955;5875.618084824494;5912.9113063304085;5985.820425387245;5999.460048595625;6050.42520960508;5728.770849166029;5780.9710951445395;5822.650640961513;5886.499647529922;5897.4692277694785;5774.624649397818;5795.884082318372;5823.708814559297;5826.592138550303;5839.970800146015;6333.55665103443;6363;6363.140975968231;6380.042993550958;6412.487001039953;6688.398044175999;6786.4570834333135;6838.384545390889;6839.247682754893;6902.792916212522;6784.118064651564;6794.048833163361;6816.182058153054;6817.69320380584;6854.451643868529;6347.238331400215;6350.555461117724;6357;6477.83805404864;6492.35076492347;6996.335348141918;7098.219195888448;7168.211496735355;7178.030965819652;7187.496875218789;6611.074449577063;6743.426808721216;6801.557898736665;6834.521583489208;6853.691583878737;6782.084418603426;6793.184817821794;6921.584704917721;6929.930700693029;6931.757388491378;6763;6767.966160169266;6860.794176174722;6872.828179295458;6891.241963384124;6807;6836.4530837532875;6880.724771009203;6889.965550172317;6903.275156108637;5308.628396012242;5329.9467005330225;5362.490563396471;5364.51719345253;5385.272988146628;4670.696404733681;4770.76146192689;4772.3557319761385;4778.498257682893;4778.880527986758;5812.7674893003805;5821.854453638608;5887.646741195456;5890.646561206341;5913.46778789911;6582.802515924434;6777.661116944133;6785.9321406786285;6874.896876546856;6959.61722105289;5701.087825947829;5738.626989245686;5793.391693872167;5871.178035075093;5879.029960056629;5858.677772722541;5906.970465147647;5912.763489460373;5914.9112763308585;5926.822195334147;6493.253275873335;6505.869882602321;6579.24338701046;6634.535582509178;6701.698423570853;6918.377346038881;6976.511644184859;6979.022936788752;6979.162500499972;6980.162380514371;6622.503312251697;6630.038644396632;6638.668066596554;6712.798616041527;6725.562838415487;6572.375624315682;6676.265610782712;6684.498662600227;6763.7632682855865;6832.419244364285;6737.427318677967;6776.491763117688;6792.524523283323;6796.218434880052;6820.795376138525;6679.298673639198;6681.09805176295;6714.664266786739;6717.664116794239;6718.7312507499155;6539.673016349258;6628.403443690091;6634.402903738686;6729.528932974645;6732.798016059526;6571;6574.4740420765265;6656.8002959909345;6667.466602671871;6670.199576050905;6518.2178138621775;6568.934310656832;6654.201495820533;6659.267480577229;6772.492063095189;6462.806115816533;6514.967425162844;6559.344065593403;6571.441427478718;6576.572522786004 11:43:52 INFO - PID 24898 | |1;ext.html;761.2729842999936;787.2914377060645;809.0453265147124;814.4258297899979;815.48624366649;40353.79823100884;41197.58802411975;41233.793831030875;41263.38104928428;41377.79311103444;38373.42439863397;41402.37896431548;42319.78840105803;42329.153416931644;42440.15119697612;7649.158592554829;7773.378129749634;7774.53352798831;7776.183500732426;7780.766577002699;7603.847923041536;7691.653875575613;7719.228077192264;7723.961380193091;7730.149683534807;7740.535567865918;7781.610919454033;7797.259260370256;7800.843983120362;7817.765467035998;7698.807529811799;7732.497387669811;7747.109082455533;7761.340286075662;7762.340201082887;7596.354309883666;7607.315341619281;7654.578998155099;7660.2722741339485;7660.310572048486;37256.813715931516;37356.25287494262;37599.436008459896;37689;37717.811410943046;3493.965060349389;3512.701420379271;3522.383582872987;3532.487789270567;3533.9293214135573;31047.689523104706;31049;31129.844350778327;31300.53049204264;31358.52962205569;4971.254311853215;5141.383034035902;5163.974180129113;5185.792568297264;5213.921791173136;177497;184057;195615.0219248909;197263;198642;49543.50456495461;50117.498825012015;50274.74862625664;50287.49712502901;50337.74831125894;51646;51745.7412712934;52004.219936700225;52013.219801703;52063.479365205865;15669.921650391676;15830.841691583168;15833.129177895325;15837.920810395874;15909.761353579706;12916.612501624779;12922.160059596095;12926;12936.159149655243;12945.417456214493;13156.40796164175;13177.143485673592;13184.868151318364;13189.868101319056;13257.469701212036;5022.874428139326;5096.439391666913;5098;5208.427073021964;5214.322138122096;981.2003217377815;995.6316163019584;1011.1152741351318;1020.78563501664;1029.1972261635935;22540.32379028632;22777;22829.657555136688;22878.08487660475;22967.655485167736;1076.725435014082;1098.5715570927346;1098.6264670012233;1099.4667586220676;1106.3478074695884;11883.227590206609;12077.980504873782;12148.878511214774;12209.145359824905;12229;225304;225676;225965;226537;227258;52407.47592524102;52535.211971820456;52562.47437525653;52680;52743.736281319114;1351.5877657314418;1415.1509094543192;1415.6743948891813;1418.581518452059;1421.4314274290366;22071.889640551693;22182.112715491847;22303.10787568479;22324.441888952908;22838.885805570866;36363.63636363708;36369.454458183674;36381.81809090938;36475.63524364722;36486.27027459489;185583.07208463873;185733;187032;187296;187360;30321.696783031886;30768.38463230678;30924;34291.485627715105;34485.827570861984;38076.61923380731;42034;43407;43546.12907741891;43974.12051758883;32132.518012229368;32171;32561.34877302488;32828.67171328256;33043.504347434326;31733;31827.20431989219;31937.361252775278;32063;32136;34150.31699366048;35966.46050309195;35976.8201159003;36401.45397818982;36418.8179059103;30751.2312192197;30886.69113308838;30934.69065309318;31174.532382014742;31881.36237275288;22678.43303917349;22794.43013924665;22888.427789305402;22998.655020175047;23279.18522851692 11:43:52 INFO - PID 24898 | |2;jquery.html;549.5905550364979;561.9971900140499;562.8424041268444;568.4173721935016;571.7963686440044;22161.778382216173;22828.88585557074;22829.200977965775;22856.200032998848;22856.8857155714;23791.76208237917;24453.877730611322;24688.3827904302;24799;24936.12723554676;6377.968110159454;6484.481241500669;6509.739610415578;6515.283318834924;6540.803775886731;6243.719032643519;6389.169407976957;6480.254770701383;6482.935170648304;6484.221893372802;6561.2782593914635;6563.638999855006;6566.277709451956;6567.802965911006;6568.244651865049;6568.868622627545;6569.605823650572;6570.770023049195;6573.835654108638;6574.342565743435;5831;6059.091136329542;6073.028315469548;6093.360197179277;6097.268327800648;27454.17637470879;27940.161795146178;27943.301417464725;27995.440091198063;28068.578971315448;1996.790337014607;2026.2806703620297;2026.8378529717588;2028.1380413324425;2035.918563257468;18560.907195463937;18991.525211869677;19098.522536936547;19240.326588569333;19267.325643602406;2374.3826605082804;2434.6591477193206;2450.889709963056;2461.8030557555353;2475.158446128325;114442;119224.40387798006;129727;131283.34358328243;135841.6415835839;13537.1200871943;13694.219751432449;13932.860671393157;14126.858731412554;14204.579542045713;22672.886635566716;22675.43311417195;22679.433014174447;22706.205282815023;22725;9755.195288871582;10047.899521004843;10052.894181640013;10058.798824023479;10069.244806639532;9273.72178834636;9316.161545460942;9316.8602470963;9352.906470935204;9473.66842160521;8553;8736.475811451333;8797.560121993874;8913.955430222937;8966.86549701755;2650.801189910726;2708.349996000946;2722.088100486359;2730.0581299451655;2784.3874347643487;951.7335146159087;980.1178938954997;983.409954027592;985.280745056113;997.1922742578535;18629.81370186308;18684.25262989465;19005.714914276297;19329.80670193308;19398.224071037283;1034.4724190662816;1037.4345981440133;1041.432419331451;1044.4516628769957;1055.6358056470506;10562.788744225072;10635.468226588795;10637.946810266054;10737.141028717684;10757.784844303227;467364;467427;470179;470919;481978;110617.99999999838;112306;113699.43150284361;113734.43132784449;114825;1134.8921852424007;1156.919015668912;1166.78414493319;1171.3850228629867;1173.7769823733463;16965.491035268962;17247.655046899243;17276.481705548853;17587.856789308655;17699;55665.72167139138;56772.432275678366;57208.71395642995;58004;58116.70941645265;71705.6414717923;71751;72051;72335;72550;13713.794293085411;13886.583402497941;13944.79082813779;13952;13996.510122145675;22086.889565552712;22135.44661383478;22224.66663000024;22523.887380562992;22563.887180563994;17575.29698812033;17783.288668453635;18020.09899505046;18066.36767713124;18255.726164107815;15879.761803573187;16172.919135404247;16281.755773663168;16358.836411635732;16640.16799160013;18115.54711132232;18426.539336516158;18624.627507450045;18671.90664046671;18738.06309684483;13932.303384830515;13941.372638231507;13943.930280348533;13955;14000.719985600028;17367.47897563075;17503.912480437517;17623.471295861145;17786;17838.554036148682 11:43:52 INFO - PID 24898 | |3;mootools.html;1305.3799445263498;1354.0792261262338;1354.613935028517;1365.3173413293352;1378.338397569166;14632.561023169308;15926;15943.76084358734;15957;15979.920100399511;15683.137427441487;15992.600184995381;16009.119498427612;16088.436904708338;16094.59763505913;2537.949241015179;2575.8840852161698;2587.508373409056;2592.481503699258;2608.504384167002;2686.449277898026;2802;2803.8457884816326;2808.929776755577;2814.521531339677;2650.284423205733;2770.252031951382;2773.1541879726674;2774.750272475477;2777.6111344411797;2780.9443811123665;2781.2490627530456;2783.596378525113;2810.662720473536;2817.60553522507;2688.596710493422;2718.7824974002033;2746.299693578145;2750.3124218945263;2750.9037183698474;14631.268436578128;14862.331195096138;14898.478553250692;14913.925430372887;14999.925000375037;7935.801604959865;8241.175882411771;8245.670173193064;8255.215754503313;8258.215469530385;5160.8193713220235;5308.92036619451;5416.133418652997;5533.363663178746;5533.944660553423;1916.1951980168362;1926.8362189213933;1927.575933294673;1969.1434226111687;1982.4449154236693;25219.747802521924;25580.488390232276;26248;26835.731642683517;26908.865455672596;6711.697973591103;6761.154855643044;6830.658467076626;6986.999999999898;7018.052562903943;17137.91431042837;17158.656826863393;17174;17203.22585483656;17204.827951720323;7889.289963903277;7990.240927111915;8032.39757018226;8067.112617612058;8072.152423995513;7267.091613548307;7391.704331826774;7419;7427.108746950401;7436.66535005926;5010.924836127461;5167.638265321391;5184.196449550326;5189.325387699575;5423.647462914898;1467.0610809082195;1470.9264536773119;1471.8601732835364;1495.439210296139;1502.4966636176785;829.1998221716073;831.8627426474563;858.0947100808582;860.8063185783274;867.5402036920442;6910;6915.481338899603;6916.135483064617;7091.042709234291;7101.076860008166;675.4765057080801;684.6816230452863;687.9621620810904;692.6571347183076;694.4028135803205;4358.585934336233;5021.899562008739;5056.696598204046;5067.4932506749765;5128.1794912813775;20511.8974405127;20624;21529.892350538146;21886.562268754536;21908;20381.694274585596;20447.4888127798;20559.38321850347;20779.79220207809;20896.37310880676;9034.2320902724;9588.232941364675;10004.749881253027;10693.41186234749;10933.234673572933;7980.92019079825;8993.325500587613;9077.137671921157;9121.498317592595;9151.77120571991;18137;18225.633077519506;18264.45206643803;18422.90788546049;18629.44111676652;18942.52643683919;19350;19525.414237572895;19577.80422195817;19606.705899411805;10746.08658264025;10969.957854003856;10977.615783447542;11094.500747466545;11096.833547496633;13646.727065458437;13690.86309136896;13692.3838427273;13780.448782048607;13929.930350348184;10941.179411544324;11172.385518796544;11231.831522527333;11244.26912250701;11439.199256051996;10947.34315941046;10976.396298203676;11000.119990400588;11185.944070279596;11274.436278186222;9324.393914395543;9605.615775368908;9632.614695412105;9695.951520242354;9700.417974921527;6863.210730766026;6941.375276225164;7071.7878463646175;7093;7104.502684812013;7284.016657751135;7286.744963926237;7352.70589176427;7355.411567074728;7470.663820128216 11:43:52 INFO - PID 24898 | |4;prototype.html;470.14199086666844;515.5154155094211;515.7859488312349;523.1211564571519;524.8215606693724;6311.842203944898;6333.968330158343;6393.680315984194;6415.133956915821;6462.2891481937;6234.719437625306;6238.968805155979;6281.623102613847;6318.557700960934;6339.809805705825;5129.666571672848;5245.085543776513;5246.658967167122;5253.4221235664045;5268.0517506848755;4871.975640121795;5195.792168313282;5249.1601343785005;5253.44838791927;5314.601404894629;4963.1810751226;4974.850754477371;5004.199328107504;5017.071841709278;5045.4450010499;4975.477574854661;4987.825426110105;5008.549230569248;5020.548595055337;5044.470330615288;4326.58897404746;4463.732176069446;4484.775761211927;4492.236319825637;4510.534570774942;6100.786472473442;6159.3224745277985;6186.267845003406;6212.534059945477;6213.2233470816145;5757.337906140806;5780.797672081499;5792.131180322943;5796.478316951452;5823.38854420284;6667.7666281680395;6690.7323707051655;6694.292955296368;6702.631355275458;6721.462283017347;4897.951020489785;4917.852464426073;4921.532454416824;4931.950680493221;4953.628477864138;6622.801315960577;6712.865742685119;6810.353016463478;6824.727010919607;6902.309769023108;4974.452810190876;4975.4527002029745;4981.2030075187795;4997;5034.993001399735;5075.11185542536;5079.517445842639;5132.101882170605;5152.433232344439;5159.380874295109;5714.885702285931;5725.627834190765;5742.712864356766;5761.049426844524;5816.185733997244;6651.201855777338;6664.400203981665;6731.124953755981;6781.491388145909;6782.118324617768;1753.9035353055704;1766.9558261043576;1774.7160454327245;1779.67076090921;1783.7324401339904;1164.574930150506;1200.2978257719158;1207.565276500459;1216.2884712443142;1216.4404373988064;5671.971640141773;5676.914846277309;5685.630434021776;5698.401667824902;5704.286964129484;6744.966275168593;6756.76351327711;6776;6806.379543875643;6808.148981377328;5704.286964129484;5721.57088218377;5740.770369185186;5774.133879918046;5803.82588522345;3570.4111670306465;3576.088097535112;3589.2462582857893;3608.891733248007;3615.1323682316056;6395.848747225451;6449.96775016122;6466.224053113657;6519.4132528072705;6541.149650545399;6775.661216939134;6882.174139103239;6912.101426814482;6924.3421874921805;6973.19808222061;6094.238220222473;6373.7131829066875;6413.647249401328;6425.357464253537;6455.289918109004;6535.215774107138;6544.54188206821;6574.013897915351;6648.501362397937;6754.18949726036;6569.57297775643;6623.735050597922;6643.900341494785;6703.363180497845;6721.193456785217;6566.946369938002;6576.704048317933;6589.439897608565;6607.768728094494;6674.365935236145;4989.825356112518;5008.348914641073;5012.799488020584;5064.518870707277;5088.287639730367;6570.901436478553;6706.631135287606;6743.2582415935185;6883.27725588806;6907.551009184387;6423.9036414452885;6514.967425162844;6517.217933847968;6541.934580654132;6605.853097743348;6504.642244676399;6504.642244676588;6539.70571324282;6561.1470508833545;6574.441172500391;6385.393387628168;6480;6512;6520.902186467301;6579.703913324008;6592.17597800275;6618.7352505899225;6643.933560664332;6709.496787740842;6720.294369091371;6273.529485288713;6387.904181437189;6446.871062578628;6470.482361410982;6495.9281718517805 11:43:52 INFO - PID 24898 | |5;yui.html;897.6274845938932;908.9681861134859;924.3529529329471;928.3965422475391;928.8049509602984;18520.444386668405;19338.419847404566;19355.806441935594;19364.225430982744;19416.22335106594;17513;17531.2110955007;17548;17620.82379176211;17738.467845964642;945.3524335829944;970.3741086998881;972.4262685015839;974.2644303550809;975.9463229522373;981.0973904008293;984.148711364668;984.1929617713442;985.0199051943326;985.3644399362407;991.5637119667359;1030.2942484398175;1034.0280136671543;1037.4138611684375;1039.8544203811473;1021.7956408718286;1024.3085917006065;1027.5273374247893;1028.9897101028969;1030.845373194023;728.9854202915965;747.8317378589828;749.0711517718045;752.3943225703307;753.7399597138979;19378.418647440598;19488.610227795507;19519.316823911096;19544.31594894186;19574.902125489425;21111.68332475014;21145.15419383223;22127.225547105936;22342.10631574735;22384.328470145923;17497.912510437494;17684.115794210236;17788;17874.731879021823;17917.910410447865;3785.716071294664;3815;3815.67566756826;3817.064819119306;3821.159344944108;101489;132658.3367083168;136181;136329;136658.31670841682;16664.250108745135;17185.570360741083;17254.913725431292;17276.65446691059;17290.481285561455;30769.846150769103;31074.378512430078;31531.684683153333;31787;31796.20509487235;9018.413803102778;9018.819623607491;9024.909750902538;9067.727968160965;9094.81810363789;4072.205919845661;4080.9183816323507;4164.7917604120275;4165.229432554987;4183.769892655933;5334.093204155303;5402.297701298885;5407.70257635826;5441.374241962225;5442.863928401822;1077.0414331245197;1088.6733979806027;1105.9778804424027;1114.6266000889793;1115.0132133062298;696.923338432772;707.8265824872939;715.9797288863452;720.045939130654;729.6534146280475;12199.451024703909;12684;13018.739625207443;13028.54400095992;13231.404586793617;668.7926742709775;679.0832376292065;682.9112215411965;685.8491131950963;692.0933577014027;5439.184122381675;5541.750621222055;5553.722313884289;5557.333120025542;5666.546676265889;125561.37219314028;126339;128271;130216.3489182567;131965;107833;110108.4494577522;110182;113280;117551.41224293824;95821.52089239508;97133;98131;98158.5092074535;98742.5062874681;10306.793864122526;10413.219008574539;10418.583256669648;10644.308119972176;10832.18758593093;44180.337294939956;44202.3369649462;45076.549234507234;46898.765506173615;47178.52821471879;58264.708676458045;59411.70294148502;59577.40422595892;60680;60768.696156518934;14915.552533424014;15337.6165595861;15348.693026139192;15534.533963981099;15559.533214003599;16535.83464165343;16802.24389902482;16856.325746969986;16946.915265423595;16960.151992400082;15621.531354059396;15635.76546351783;15791.763123553386;15881.364745410516;16030.759538606697;15427.382904683687;15571.76642350343;15711.292991815168;15742.685146297239;15767;15525.611859703598;15664.060156390653;15766.369345226063;15775.447859324868;15831.604209894846;10834;10907.509162087883;11022.669319920415;11250;11250.943745281222;11830.349330786888;11930.701732456759;12037.277763333877;12069.27584344942;12237.265764054186 11:43:52 INFO - PID 24898 | __end_tp_report 11:43:52 INFO - PID 24898 | __start_cc_report 11:43:52 INFO - PID 24898 | _x_x_mozilla_cycle_collect,273 11:43:52 INFO - PID 24898 | __end_cc_report 11:43:52 INFO - PID 24898 | __startTimestamp1505760232676__endTimestamp 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | ------- Summary: start ------- 11:43:52 INFO - PID 24898 | Number of tests: 6 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | [#0] dojo.html Cycles:165 Average:6287.05 Median:6568.93 stddev:759.01 (11.6%) stddev-sans-first:719.14 11:43:52 INFO - PID 24898 | Values: 3105.9 3161.8 3182.3 3189.4 3196.6 6174.7 6313.4 6313.7 6369.5 6422.1 6243.3 6322.6 6334.4 6359.6 6389.8 5884.2 5955.3 5958.0 5962.2 5978.1 5857.1 5882.5 5910.3 5969.2 5984.6 5875.6 5912.9 5985.8 5999.5 6050.4 5728.8 5781.0 5822.7 5886.5 5897.5 5774.6 5795.9 5823.7 5826.6 5840.0 6333.6 6363.0 6363.1 6380.0 6412.5 6688.4 6786.5 6838.4 6839.2 6902.8 6784.1 6794.0 6816.2 6817.7 6854.5 6347.2 6350.6 6357.0 6477.8 6492.4 6996.3 7098.2 7168.2 7178.0 7187.5 6611.1 6743.4 6801.6 6834.5 6853.7 6782.1 6793.2 6921.6 6929.9 6931.8 6763.0 6768.0 6860.8 6872.8 6891.2 6807.0 6836.5 6880.7 6890.0 6903.3 5308.6 5329.9 5362.5 5364.5 5385.3 4670.7 4770.8 4772.4 4778.5 4778.9 5812.8 5821.9 5887.6 5890.6 5913.5 6582.8 6777.7 6785.9 6874.9 6959.6 5701.1 5738.6 5793.4 5871.2 5879.0 5858.7 5907.0 5912.8 5914.9 5926.8 6493.3 6505.9 6579.2 6634.5 6701.7 6918.4 6976.5 6979.0 6979.2 6980.2 6622.5 6630.0 6638.7 6712.8 6725.6 6572.4 6676.3 6684.5 6763.8 6832.4 6737.4 6776.5 6792.5 6796.2 6820.8 6679.3 6681.1 6714.7 6717.7 6718.7 6539.7 6628.4 6634.4 6729.5 6732.8 6571.0 6574.5 6656.8 6667.5 6670.2 6518.2 6568.9 6654.2 6659.3 6772.5 6462.8 6515.0 6559.3 6571.4 6576.6 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | [#1] ext.html Cycles:180 Average:36947.41 Median:3517.54 stddev:52348.74 (1488.2%) stddev-sans-first:52425.08 11:43:52 INFO - PID 24898 | Values: 761.3 787.3 809.0 814.4 815.5 40353.8 41197.6 41233.8 41263.4 41377.8 38373.4 41402.4 42319.8 42329.2 42440.2 7649.2 7773.4 7774.5 7776.2 7780.8 7603.8 7691.7 7719.2 7724.0 7730.1 7740.5 7781.6 7797.3 7800.8 7817.8 7698.8 7732.5 7747.1 7761.3 7762.3 7596.4 7607.3 7654.6 7660.3 7660.3 37256.8 37356.3 37599.4 37689.0 37717.8 3494.0 3512.7 3522.4 3532.5 3533.9 31047.7 31049.0 31129.8 31300.5 31358.5 4971.3 5141.4 5164.0 5185.8 5213.9 177497.0 184057.0 195615.0 197263.0 198642.0 49543.5 50117.5 50274.7 50287.5 50337.7 51646.0 51745.7 52004.2 52013.2 52063.5 15669.9 15830.8 15833.1 15837.9 15909.8 12916.6 12922.2 12926.0 12936.2 12945.4 13156.4 13177.1 13184.9 13189.9 13257.5 5022.9 5096.4 5098.0 5208.4 5214.3 981.2 995.6 1011.1 1020.8 1029.2 22540.3 22777.0 22829.7 22878.1 22967.7 1076.7 1098.6 1098.6 1099.5 1106.3 11883.2 12078.0 12148.9 12209.1 12229.0 225304.0 225676.0 225965.0 226537.0 227258.0 52407.5 52535.2 52562.5 52680.0 52743.7 1351.6 1415.2 1415.7 1418.6 1421.4 22071.9 22182.1 22303.1 22324.4 22838.9 36363.6 36369.5 36381.8 36475.6 36486.3 185583.1 185733.0 187032.0 187296.0 187360.0 30321.7 30768.4 30924.0 34291.5 34485.8 38076.6 42034.0 43407.0 43546.1 43974.1 32132.5 32171.0 32561.3 32828.7 33043.5 31733.0 31827.2 31937.4 32063.0 32136.0 34150.3 35966.5 35976.8 36401.5 36418.8 30751.2 30886.7 30934.7 31174.5 31881.4 22678.4 22794.4 22888.4 22998.7 23279.2 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | [#2] jquery.html Cycles:180 Average:33593.34 Median:22674.16 stddev:79339.35 (349.9%) stddev-sans-first:79523.12 11:43:52 INFO - PID 24898 | Values: 549.6 562.0 562.8 568.4 571.8 22161.8 22828.9 22829.2 22856.2 22856.9 23791.8 24453.9 24688.4 24799.0 24936.1 6378.0 6484.5 6509.7 6515.3 6540.8 6243.7 6389.2 6480.3 6482.9 6484.2 6561.3 6563.6 6566.3 6567.8 6568.2 6568.9 6569.6 6570.8 6573.8 6574.3 5831.0 6059.1 6073.0 6093.4 6097.3 27454.2 27940.2 27943.3 27995.4 28068.6 1996.8 2026.3 2026.8 2028.1 2035.9 18560.9 18991.5 19098.5 19240.3 19267.3 2374.4 2434.7 2450.9 2461.8 2475.2 114442.0 119224.4 129727.0 131283.3 135841.6 13537.1 13694.2 13932.9 14126.9 14204.6 22672.9 22675.4 22679.4 22706.2 22725.0 9755.2 10047.9 10052.9 10058.8 10069.2 9273.7 9316.2 9316.9 9352.9 9473.7 8553.0 8736.5 8797.6 8914.0 8966.9 2650.8 2708.3 2722.1 2730.1 2784.4 951.7 980.1 983.4 985.3 997.2 18629.8 18684.3 19005.7 19329.8 19398.2 1034.5 1037.4 1041.4 1044.5 1055.6 10562.8 10635.5 10637.9 10737.1 10757.8 467364.0 467427.0 470179.0 470919.0 481978.0 110618.0 112306.0 113699.4 113734.4 114825.0 1134.9 1156.9 1166.8 1171.4 1173.8 16965.5 17247.7 17276.5 17587.9 17699.0 55665.7 56772.4 57208.7 58004.0 58116.7 71705.6 71751.0 72051.0 72335.0 72550.0 13713.8 13886.6 13944.8 13952.0 13996.5 22086.9 22135.4 22224.7 22523.9 22563.9 17575.3 17783.3 18020.1 18066.4 18255.7 15879.8 16172.9 16281.8 16358.8 16640.2 18115.5 18426.5 18624.6 18671.9 18738.1 13932.3 13941.4 13943.9 13955.0 14000.7 17367.5 17503.9 17623.5 17786.0 17838.6 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | [#3] mootools.html Cycles:180 Average:9229.93 Median:14813.82 stddev:6618.89 (44.7%) stddev-sans-first:6610.68 11:43:52 INFO - PID 24898 | Values: 1305.4 1354.1 1354.6 1365.3 1378.3 14632.6 15926.0 15943.8 15957.0 15979.9 15683.1 15992.6 16009.1 16088.4 16094.6 2537.9 2575.9 2587.5 2592.5 2608.5 2686.4 2802.0 2803.8 2808.9 2814.5 2650.3 2770.3 2773.2 2774.8 2777.6 2780.9 2781.2 2783.6 2810.7 2817.6 2688.6 2718.8 2746.3 2750.3 2750.9 14631.3 14862.3 14898.5 14913.9 14999.9 7935.8 8241.2 8245.7 8255.2 8258.2 5160.8 5308.9 5416.1 5533.4 5533.9 1916.2 1926.8 1927.6 1969.1 1982.4 25219.7 25580.5 26248.0 26835.7 26908.9 6711.7 6761.2 6830.7 6987.0 7018.1 17137.9 17158.7 17174.0 17203.2 17204.8 7889.3 7990.2 8032.4 8067.1 8072.2 7267.1 7391.7 7419.0 7427.1 7436.7 5010.9 5167.6 5184.2 5189.3 5423.6 1467.1 1470.9 1471.9 1495.4 1502.5 829.2 831.9 858.1 860.8 867.5 6910.0 6915.5 6916.1 7091.0 7101.1 675.5 684.7 688.0 692.7 694.4 4358.6 5021.9 5056.7 5067.5 5128.2 20511.9 20624.0 21529.9 21886.6 21908.0 20381.7 20447.5 20559.4 20779.8 20896.4 9034.2 9588.2 10004.7 10693.4 10933.2 7980.9 8993.3 9077.1 9121.5 9151.8 18137.0 18225.6 18264.5 18422.9 18629.4 18942.5 19350.0 19525.4 19577.8 19606.7 10746.1 10970.0 10977.6 11094.5 11096.8 13646.7 13690.9 13692.4 13780.4 13929.9 10941.2 11172.4 11231.8 11244.3 11439.2 10947.3 10976.4 11000.1 11185.9 11274.4 9324.4 9605.6 9632.6 9696.0 9700.4 6863.2 6941.4 7071.8 7093.0 7104.5 7284.0 7286.7 7352.7 7355.4 7470.7 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | [#4] prototype.html Cycles:180 Average:5549.39 Median:6223.97 stddev:1551.94 (24.9%) stddev-sans-first:1508.74 11:43:52 INFO - PID 24898 | Values: 470.1 515.5 515.8 523.1 524.8 6311.8 6334.0 6393.7 6415.1 6462.3 6234.7 6239.0 6281.6 6318.6 6339.8 5129.7 5245.1 5246.7 5253.4 5268.1 4872.0 5195.8 5249.2 5253.4 5314.6 4963.2 4974.9 5004.2 5017.1 5045.4 4975.5 4987.8 5008.5 5020.5 5044.5 4326.6 4463.7 4484.8 4492.2 4510.5 6100.8 6159.3 6186.3 6212.5 6213.2 5757.3 5780.8 5792.1 5796.5 5823.4 6667.8 6690.7 6694.3 6702.6 6721.5 4898.0 4917.9 4921.5 4932.0 4953.6 6622.8 6712.9 6810.4 6824.7 6902.3 4974.5 4975.5 4981.2 4997.0 5035.0 5075.1 5079.5 5132.1 5152.4 5159.4 5714.9 5725.6 5742.7 5761.0 5816.2 6651.2 6664.4 6731.1 6781.5 6782.1 1753.9 1767.0 1774.7 1779.7 1783.7 1164.6 1200.3 1207.6 1216.3 1216.4 5672.0 5676.9 5685.6 5698.4 5704.3 6745.0 6756.8 6776.0 6806.4 6808.1 5704.3 5721.6 5740.8 5774.1 5803.8 3570.4 3576.1 3589.2 3608.9 3615.1 6395.8 6450.0 6466.2 6519.4 6541.1 6775.7 6882.2 6912.1 6924.3 6973.2 6094.2 6373.7 6413.6 6425.4 6455.3 6535.2 6544.5 6574.0 6648.5 6754.2 6569.6 6623.7 6643.9 6703.4 6721.2 6566.9 6576.7 6589.4 6607.8 6674.4 4989.8 5008.3 5012.8 5064.5 5088.3 6570.9 6706.6 6743.3 6883.3 6907.6 6423.9 6515.0 6517.2 6541.9 6605.9 6504.6 6504.6 6539.7 6561.1 6574.4 6385.4 6480.0 6512.0 6520.9 6579.7 6592.2 6618.7 6643.9 6709.5 6720.3 6273.5 6387.9 6446.9 6470.5 6495.9 11:43:52 INFO - PID 24898 | 11:43:52 INFO - PID 24898 | [#5] yui.html Cycles:180 Average:24389.18 Median:19347.11 stddev:35306.56 (182.5%) stddev-sans-first:35361.54 11:43:52 INFO - PID 24898 | Values: 897.6 909.0 924.4 928.4 928.8 18520.4 19338.4 19355.8 19364.2 19416.2 17513.0 17531.2 17548.0 17620.8 17738.5 945.4 970.4 972.4 974.3 975.9 981.1 984.1 984.2 985.0 985.4 991.6 1030.3 1034.0 1037.4 1039.9 1021.8 1024.3 1027.5 1029.0 1030.8 729.0 747.8 749.1 752.4 753.7 19378.4 19488.6 19519.3 19544.3 19574.9 21111.7 21145.2 22127.2 22342.1 22384.3 17497.9 17684.1 17788.0 17874.7 17917.9 3785.7 3815.0 3815.7 3817.1 3821.2 101489.0 132658.3 136181.0 136329.0 136658.3 16664.3 17185.6 17254.9 17276.7 17290.5 30769.8 31074.4 31531.7 31787.0 31796.2 9018.4 9018.8 9024.9 9067.7 9094.8 4072.2 4080.9 4164.8 4165.2 4183.8 5334.1 5402.3 5407.7 5441.4 5442.9 1077.0 1088.7 1106.0 1114.6 1115.0 696.9 707.8 716.0 720.0 729.7 12199.5 12684.0 13018.7 13028.5 13231.4 668.8 679.1 682.9 685.8 692.1 5439.2 5541.8 5553.7 5557.3 5666.5 125561.4 126339.0 128271.0 130216.3 131965.0 107833.0 110108.4 110182.0 113280.0 117551.4 95821.5 97133.0 98131.0 98158.5 98742.5 10306.8 10413.2 10418.6 10644.3 10832.2 44180.3 44202.3 45076.5 46898.8 47178.5 58264.7 59411.7 59577.4 60680.0 60768.7 14915.6 15337.6 15348.7 15534.5 15559.5 16535.8 16802.2 16856.3 16946.9 16960.2 15621.5 15635.8 15791.8 15881.4 16030.8 15427.4 15571.8 15711.3 15742.7 15767.0 15525.6 15664.1 15766.4 15775.4 15831.6 10834.0 10907.5 11022.7 11250.0 11250.9 11830.3 11930.7 12037.3 12069.3 12237.3 11:43:52 INFO - PID 24898 | -------- Summary: end -------- 11:43:52 INFO - PID 24898 | 11:43:53 INFO - TEST-INFO | 24898: exit 0 11:43:53 INFO - TEST-OK | dromaeo_css | took 1108836ms 11:43:53 INFO - TEST-START | kraken 11:43:53 INFO - Initialising browser for kraken test... 11:43:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45735/getInfo.html -profile /tmp/tmp3B6UtC/profile 11:43:53 INFO - TEST-INFO | started process 25272 (/builds/slave/test/build/application/firefox/firefox http://localhost:45735/getInfo.html) 11:43:58 INFO - TEST-INFO | 25272: exit 0 11:43:58 INFO - Browser initialized. 11:43:58 INFO - Running cycle 1/1 for kraken test... 11:43:58 INFO - Using env: {'DISPLAY': ':0', 11:43:58 INFO - 'HOME': '/home/cltbld', 11:43:58 INFO - 'JSGC_DISABLE_POISONING': '1', 11:43:58 INFO - 'LANG': 'en_US.UTF-8', 11:43:58 INFO - 'LANGUAGE': 'en_US:en', 11:43:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:43:58 INFO - 'LOGNAME': 'cltbld', 11:43:58 INFO - 'MAIL': '/var/mail/cltbld', 11:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:58 INFO - 'MOZ_CRASHREPORTER': '1', 11:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:43:58 INFO - 'MOZ_NO_REMOTE': '1', 11:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:58 INFO - 'NO_EM_RESTART': '1', 11:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:58 INFO - 'PWD': '/builds/slave/test', 11:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:58 INFO - 'RUST_BACKTRACE': 'full', 11:43:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:43:58 INFO - 'SHELL': '/bin/bash', 11:43:58 INFO - 'SHLVL': '1', 11:43:58 INFO - 'TERM': 'linux', 11:43:58 INFO - 'TMOUT': '86400', 11:43:58 INFO - 'USER': 'cltbld', 11:43:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932', 11:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:58 INFO - '_': '/tools/buildbot/bin/python'} 11:43:58 INFO - TEST-INFO | started process 25502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3B6UtC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:59 INFO - PID 25502 | 11:43:59 INFO - PID 25502 | (/builds/slave/test/build/application/firefox/firefox:25551): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:43:59 INFO - PID 25502 | 11:44:09 INFO - PID 25502 | RSS: Main: 157245440 11:44:09 INFO - PID 25502 | 11:44:12 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45735/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:13 INFO - PID 25502 | RSS: Main: 163598336 11:44:13 INFO - PID 25502 | 11:44:15 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45735/tests/kraken/driver.html?testName=audio-dft) 11:44:16 INFO - PID 25502 | RSS: Main: 163561472 11:44:16 INFO - PID 25502 | 11:44:19 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45735/tests/kraken/driver.html?testName=audio-fft) 11:44:19 INFO - PID 25502 | RSS: Main: 158937088 11:44:19 INFO - PID 25502 | 11:44:22 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45735/tests/kraken/driver.html?testName=audio-oscillator) 11:44:22 INFO - PID 25502 | RSS: Main: 159354880 11:44:22 INFO - PID 25502 | 11:44:24 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:25 INFO - PID 25502 | RSS: Main: 160100352 11:44:25 INFO - PID 25502 | 11:44:28 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45735/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:29 INFO - PID 25502 | RSS: Main: 162304000 11:44:29 INFO - PID 25502 | 11:44:32 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45735/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:33 INFO - PID 25502 | RSS: Main: 162480128 11:44:33 INFO - PID 25502 | 11:44:36 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45735/tests/kraken/driver.html?testName=json-parse-financial) 11:44:37 INFO - PID 25502 | RSS: Main: 162267136 11:44:37 INFO - PID 25502 | 11:44:38 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:39 INFO - PID 25502 | RSS: Main: 162545664 11:44:39 INFO - PID 25502 | 11:44:40 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:41 INFO - PID 25502 | RSS: Main: 162861056 11:44:41 INFO - PID 25502 | 11:44:43 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:44 INFO - PID 25502 | RSS: Main: 159531008 11:44:44 INFO - PID 25502 | 11:44:46 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:47 INFO - PID 25502 | RSS: Main: 159723520 11:44:47 INFO - PID 25502 | 11:44:50 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:51 INFO - PID 25502 | RSS: Main: 159797248 11:44:51 INFO - PID 25502 | 11:44:52 INFO - PID 25502 | Cycle 1(1): loaded http://localhost:45735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45735/tests/kraken/driver.html?testName=ai-astar) 11:44:53 INFO - PID 25502 | RSS: Main: 161067008 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | __start_tp_report 11:44:53 INFO - PID 25502 | _x_x_mozilla_page_load 11:44:53 INFO - PID 25502 | _x_x_mozilla_page_load_details 11:44:53 INFO - PID 25502 | |i|pagename|runs| 11:44:53 INFO - PID 25502 | |0;ai-astar;107;107;108;108;108;106;106;108;109;108 11:44:53 INFO - PID 25502 | |1;audio-beat-detection;117;115;114;120;115;125;115;145;117;122 11:44:53 INFO - PID 25502 | |2;audio-dft;165;164;164;163;164;163;163;165;169;166 11:44:53 INFO - PID 25502 | |3;audio-fft;75;76;75;74;74;75;74;76;75;75 11:44:53 INFO - PID 25502 | |4;audio-oscillator;79;79;79;80;79;80;80;81;80;80 11:44:53 INFO - PID 25502 | |5;imaging-gaussian-blur;116;116;114;113;114;114;114;117;113;117 11:44:53 INFO - PID 25502 | |6;imaging-darkroom;148;148;148;147;147;148;148;148;147;147 11:44:53 INFO - PID 25502 | |7;imaging-desaturate;95;94;94;94;93;94;94;94;100;99 11:44:53 INFO - PID 25502 | |8;json-parse-financial;54;54;54;56;53;54;55;60;54;53 11:44:53 INFO - PID 25502 | |9;json-stringify-tinderbox;37;37;37;37;38;38;38;37;38;37 11:44:53 INFO - PID 25502 | |10;stanford-crypto-aes;75;76;75;74;75;74;75;73;74;76 11:44:53 INFO - PID 25502 | |11;stanford-crypto-ccm;109;110;111;113;110;117;107;115;108;111 11:44:53 INFO - PID 25502 | |12;stanford-crypto-pbkdf2;167;172;167;165;168;176;165;169;167;165 11:44:53 INFO - PID 25502 | |13;stanford-crypto-sha256-iterative;64;65;68;65;65;67;64;65;70;66 11:44:53 INFO - PID 25502 | __end_tp_report 11:44:53 INFO - PID 25502 | __start_cc_report 11:44:53 INFO - PID 25502 | _x_x_mozilla_cycle_collect,742 11:44:53 INFO - PID 25502 | __end_cc_report 11:44:53 INFO - PID 25502 | __startTimestamp1505760293070__endTimestamp 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | ------- Summary: start ------- 11:44:53 INFO - PID 25502 | Number of tests: 14 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#0] ai-astar Cycles:10 Average:107.50 Median:108.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 11:44:53 INFO - PID 25502 | Values: 107.0 107.0 108.0 108.0 108.0 106.0 106.0 108.0 109.0 108.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:118.50 stddev:9.31 (7.9%) stddev-sans-first:9.79 11:44:53 INFO - PID 25502 | Values: 117.0 115.0 114.0 120.0 115.0 125.0 115.0 145.0 117.0 122.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 11:44:53 INFO - PID 25502 | Values: 165.0 164.0 164.0 163.0 164.0 163.0 163.0 165.0 169.0 166.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#3] audio-fft Cycles:10 Average:74.90 Median:75.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 11:44:53 INFO - PID 25502 | Values: 75.0 76.0 75.0 74.0 74.0 75.0 74.0 76.0 75.0 75.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:80.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 11:44:53 INFO - PID 25502 | Values: 79.0 79.0 79.0 80.0 79.0 80.0 80.0 81.0 80.0 80.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.55 (1.3%) stddev-sans-first:1.58 11:44:53 INFO - PID 25502 | Values: 116.0 116.0 114.0 113.0 114.0 114.0 114.0 117.0 113.0 117.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 11:44:53 INFO - PID 25502 | Values: 148.0 148.0 148.0 147.0 147.0 148.0 148.0 148.0 147.0 147.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.38 (2.5%) stddev-sans-first:2.52 11:44:53 INFO - PID 25502 | Values: 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 100.0 99.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:2.06 (3.8%) stddev-sans-first:2.17 11:44:53 INFO - PID 25502 | Values: 54.0 54.0 54.0 56.0 53.0 54.0 55.0 60.0 54.0 53.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#9] json-stringify-tinderbox Cycles:10 Average:37.40 Median:37.50 stddev:0.52 (1.4%) stddev-sans-first:0.53 11:44:53 INFO - PID 25502 | Values: 37.0 37.0 37.0 37.0 38.0 38.0 38.0 37.0 38.0 37.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 11:44:53 INFO - PID 25502 | Values: 75.0 76.0 75.0 74.0 75.0 74.0 75.0 73.0 74.0 76.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#11] stanford-crypto-ccm Cycles:10 Average:111.10 Median:111.00 stddev:3.11 (2.8%) stddev-sans-first:3.20 11:44:53 INFO - PID 25502 | Values: 109.0 110.0 111.0 113.0 110.0 117.0 107.0 115.0 108.0 111.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:167.50 stddev:3.51 (2.1%) stddev-sans-first:3.70 11:44:53 INFO - PID 25502 | Values: 167.0 172.0 167.0 165.0 168.0 176.0 165.0 169.0 167.0 165.0 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.50 stddev:1.91 (2.9%) stddev-sans-first:1.90 11:44:53 INFO - PID 25502 | Values: 64.0 65.0 68.0 65.0 65.0 67.0 64.0 65.0 70.0 66.0 11:44:53 INFO - PID 25502 | -------- Summary: end -------- 11:44:53 INFO - PID 25502 | 11:44:53 INFO - PID 25502 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:44:53 INFO - TEST-INFO | 25502: exit 0 11:44:53 INFO - TEST-OK | kraken | took 60346ms 11:44:53 INFO - SUITE-END | took 1169s 11:44:54 INFO - Completed test suite (00:19:29) 11:44:54 INFO - javascript benchmark 11:44:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8463.481396184032, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.8912938047165, 3161.7944833585816, 3182.347618738159, 3189.378071276101, 3196.6483686794454, 6174.6912654367325, 6313.368663133684, 6313.684315784215, 6369.490440764739, 6422.100905873182, 6243.250809902806, 6322.620642761438, 6334.366563343663, 6359.6184228946295, 6389.840253993652, 5884.2056322396575, 5955.285365756094, 5958.046712525997, 5962.165296858454, 5978.103284507315, 5857.092150716646, 5882.499987501067, 5910.320313163977, 5969.22400087988, 5984.5511586630955, 5875.618084824494, 5912.9113063304085, 5985.820425387245, 5999.460048595625, 6050.42520960508, 5728.770849166029, 5780.9710951445395, 5822.650640961513, 5886.499647529922, 5897.4692277694785, 5774.624649397818, 5795.884082318372, 5823.708814559297, 5826.592138550303, 5839.970800146015, 6333.55665103443, 6363.0, 6363.140975968231, 6380.042993550958, 6412.487001039953, 6688.398044175999, 6786.4570834333135, 6838.384545390889, 6839.247682754893, 6902.792916212522, 6784.118064651564, 6794.048833163361, 6816.182058153054, 6817.69320380584, 6854.451643868529, 6347.238331400215, 6350.555461117724, 6357.0, 6477.83805404864, 6492.35076492347, 6996.335348141918, 7098.219195888448, 7168.211496735355, 7178.030965819652, 7187.496875218789, 6611.074449577063, 6743.426808721216, 6801.557898736665, 6834.521583489208, 6853.691583878737, 6782.084418603426, 6793.184817821794, 6921.584704917721, 6929.930700693029, 6931.757388491378, 6763.0, 6767.966160169266, 6860.794176174722, 6872.828179295458, 6891.241963384124, 6807.0, 6836.4530837532875, 6880.724771009203, 6889.965550172317, 6903.275156108637, 5308.628396012242, 5329.9467005330225, 5362.490563396471, 5364.51719345253, 5385.272988146628, 4670.696404733681, 4770.76146192689, 4772.3557319761385, 4778.498257682893, 4778.880527986758, 5812.7674893003805, 5821.854453638608, 5887.646741195456, 5890.646561206341, 5913.46778789911, 6582.802515924434, 6777.661116944133, 6785.9321406786285, 6874.896876546856, 6959.61722105289, 5701.087825947829, 5738.626989245686, 5793.391693872167, 5871.178035075093, 5879.029960056629, 5858.677772722541, 5906.970465147647, 5912.763489460373, 5914.9112763308585, 5926.822195334147, 6493.253275873335, 6505.869882602321, 6579.24338701046, 6634.535582509178, 6701.698423570853, 6918.377346038881, 6976.511644184859, 6979.022936788752, 6979.162500499972, 6980.162380514371, 6622.503312251697, 6630.038644396632, 6638.668066596554, 6712.798616041527, 6725.562838415487, 6572.375624315682, 6676.265610782712, 6684.498662600227, 6763.7632682855865, 6832.419244364285, 6737.427318677967, 6776.491763117688, 6792.524523283323, 6796.218434880052, 6820.795376138525, 6679.298673639198, 6681.09805176295, 6714.664266786739, 6717.664116794239, 6718.7312507499155, 6539.673016349258, 6628.403443690091, 6634.402903738686, 6729.528932974645, 6732.798016059526, 6571.0, 6574.4740420765265, 6656.8002959909345, 6667.466602671871, 6670.199576050905, 6518.2178138621775, 6568.934310656832, 6654.201495820533, 6659.267480577229, 6772.492063095189, 6462.806115816533, 6514.967425162844, 6559.344065593403, 6571.441427478718, 6576.572522786004], "value": 6228.514119836408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.2729842999936, 787.2914377060645, 809.0453265147124, 814.4258297899979, 815.48624366649, 40353.79823100884, 41197.58802411975, 41233.793831030875, 41263.38104928428, 41377.79311103444, 38373.42439863397, 41402.37896431548, 42319.78840105803, 42329.153416931644, 42440.15119697612, 7649.158592554829, 7773.378129749634, 7774.53352798831, 7776.183500732426, 7780.766577002699, 7603.847923041536, 7691.653875575613, 7719.228077192264, 7723.961380193091, 7730.149683534807, 7740.535567865918, 7781.610919454033, 7797.259260370256, 7800.843983120362, 7817.765467035998, 7698.807529811799, 7732.497387669811, 7747.109082455533, 7761.340286075662, 7762.340201082887, 7596.354309883666, 7607.315341619281, 7654.578998155099, 7660.2722741339485, 7660.310572048486, 37256.813715931516, 37356.25287494262, 37599.436008459896, 37689.0, 37717.811410943046, 3493.965060349389, 3512.701420379271, 3522.383582872987, 3532.487789270567, 3533.9293214135573, 31047.689523104706, 31049.0, 31129.844350778327, 31300.53049204264, 31358.52962205569, 4971.254311853215, 5141.383034035902, 5163.974180129113, 5185.792568297264, 5213.921791173136, 177497.0, 184057.0, 195615.0219248909, 197263.0, 198642.0, 49543.50456495461, 50117.498825012015, 50274.74862625664, 50287.49712502901, 50337.74831125894, 51646.0, 51745.7412712934, 52004.219936700225, 52013.219801703, 52063.479365205865, 15669.921650391676, 15830.841691583168, 15833.129177895325, 15837.920810395874, 15909.761353579706, 12916.612501624779, 12922.160059596095, 12926.0, 12936.159149655243, 12945.417456214493, 13156.40796164175, 13177.143485673592, 13184.868151318364, 13189.868101319056, 13257.469701212036, 5022.874428139326, 5096.439391666913, 5098.0, 5208.427073021964, 5214.322138122096, 981.2003217377815, 995.6316163019584, 1011.1152741351318, 1020.78563501664, 1029.1972261635935, 22540.32379028632, 22777.0, 22829.657555136688, 22878.08487660475, 22967.655485167736, 1076.725435014082, 1098.5715570927346, 1098.6264670012233, 1099.4667586220676, 1106.3478074695884, 11883.227590206609, 12077.980504873782, 12148.878511214774, 12209.145359824905, 12229.0, 225304.0, 225676.0, 225965.0, 226537.0, 227258.0, 52407.47592524102, 52535.211971820456, 52562.47437525653, 52680.0, 52743.736281319114, 1351.5877657314418, 1415.1509094543192, 1415.6743948891813, 1418.581518452059, 1421.4314274290366, 22071.889640551693, 22182.112715491847, 22303.10787568479, 22324.441888952908, 22838.885805570866, 36363.63636363708, 36369.454458183674, 36381.81809090938, 36475.63524364722, 36486.27027459489, 185583.07208463873, 185733.0, 187032.0, 187296.0, 187360.0, 30321.696783031886, 30768.38463230678, 30924.0, 34291.485627715105, 34485.827570861984, 38076.61923380731, 42034.0, 43407.0, 43546.12907741891, 43974.12051758883, 32132.518012229368, 32171.0, 32561.34877302488, 32828.67171328256, 33043.504347434326, 31733.0, 31827.20431989219, 31937.361252775278, 32063.0, 32136.0, 34150.31699366048, 35966.46050309195, 35976.8201159003, 36401.45397818982, 36418.8179059103, 30751.2312192197, 30886.69113308838, 30934.69065309318, 31174.532382014742, 31881.36237275288, 22678.43303917349, 22794.43013924665, 22888.427789305402, 22998.655020175047, 23279.18522851692], "value": 16872.641915333315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5905550364979, 561.9971900140499, 562.8424041268444, 568.4173721935016, 571.7963686440044, 22161.778382216173, 22828.88585557074, 22829.200977965775, 22856.200032998848, 22856.8857155714, 23791.76208237917, 24453.877730611322, 24688.3827904302, 24799.0, 24936.12723554676, 6377.968110159454, 6484.481241500669, 6509.739610415578, 6515.283318834924, 6540.803775886731, 6243.719032643519, 6389.169407976957, 6480.254770701383, 6482.935170648304, 6484.221893372802, 6561.2782593914635, 6563.638999855006, 6566.277709451956, 6567.802965911006, 6568.244651865049, 6568.868622627545, 6569.605823650572, 6570.770023049195, 6573.835654108638, 6574.342565743435, 5831.0, 6059.091136329542, 6073.028315469548, 6093.360197179277, 6097.268327800648, 27454.17637470879, 27940.161795146178, 27943.301417464725, 27995.440091198063, 28068.578971315448, 1996.790337014607, 2026.2806703620297, 2026.8378529717588, 2028.1380413324425, 2035.918563257468, 18560.907195463937, 18991.525211869677, 19098.522536936547, 19240.326588569333, 19267.325643602406, 2374.3826605082804, 2434.6591477193206, 2450.889709963056, 2461.8030557555353, 2475.158446128325, 114442.0, 119224.40387798006, 129727.0, 131283.34358328243, 135841.6415835839, 13537.1200871943, 13694.219751432449, 13932.860671393157, 14126.858731412554, 14204.579542045713, 22672.886635566716, 22675.43311417195, 22679.433014174447, 22706.205282815023, 22725.0, 9755.195288871582, 10047.899521004843, 10052.894181640013, 10058.798824023479, 10069.244806639532, 9273.72178834636, 9316.161545460942, 9316.8602470963, 9352.906470935204, 9473.66842160521, 8553.0, 8736.475811451333, 8797.560121993874, 8913.955430222937, 8966.86549701755, 2650.801189910726, 2708.349996000946, 2722.088100486359, 2730.0581299451655, 2784.3874347643487, 951.7335146159087, 980.1178938954997, 983.409954027592, 985.280745056113, 997.1922742578535, 18629.81370186308, 18684.25262989465, 19005.714914276297, 19329.80670193308, 19398.224071037283, 1034.4724190662816, 1037.4345981440133, 1041.432419331451, 1044.4516628769957, 1055.6358056470506, 10562.788744225072, 10635.468226588795, 10637.946810266054, 10737.141028717684, 10757.784844303227, 467364.0, 467427.0, 470179.0, 470919.0, 481978.0, 110617.99999999838, 112306.0, 113699.43150284361, 113734.43132784449, 114825.0, 1134.8921852424007, 1156.919015668912, 1166.78414493319, 1171.3850228629867, 1173.7769823733463, 16965.491035268962, 17247.655046899243, 17276.481705548853, 17587.856789308655, 17699.0, 55665.72167139138, 56772.432275678366, 57208.71395642995, 58004.0, 58116.70941645265, 71705.6414717923, 71751.0, 72051.0, 72335.0, 72550.0, 13713.794293085411, 13886.583402497941, 13944.79082813779, 13952.0, 13996.510122145675, 22086.889565552712, 22135.44661383478, 22224.66663000024, 22523.887380562992, 22563.887180563994, 17575.29698812033, 17783.288668453635, 18020.09899505046, 18066.36767713124, 18255.726164107815, 15879.761803573187, 16172.919135404247, 16281.755773663168, 16358.836411635732, 16640.16799160013, 18115.54711132232, 18426.539336516158, 18624.627507450045, 18671.90664046671, 18738.06309684483, 13932.303384830515, 13941.372638231507, 13943.930280348533, 13955.0, 14000.719985600028, 17367.47897563075, 17503.912480437517, 17623.471295861145, 17786.0, 17838.554036148682], "value": 11716.375315985908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.3799445263498, 1354.0792261262338, 1354.613935028517, 1365.3173413293352, 1378.338397569166, 14632.561023169308, 15926.0, 15943.76084358734, 15957.0, 15979.920100399511, 15683.137427441487, 15992.600184995381, 16009.119498427612, 16088.436904708338, 16094.59763505913, 2537.949241015179, 2575.8840852161698, 2587.508373409056, 2592.481503699258, 2608.504384167002, 2686.449277898026, 2802.0, 2803.8457884816326, 2808.929776755577, 2814.521531339677, 2650.284423205733, 2770.252031951382, 2773.1541879726674, 2774.750272475477, 2777.6111344411797, 2780.9443811123665, 2781.2490627530456, 2783.596378525113, 2810.662720473536, 2817.60553522507, 2688.596710493422, 2718.7824974002033, 2746.299693578145, 2750.3124218945263, 2750.9037183698474, 14631.268436578128, 14862.331195096138, 14898.478553250692, 14913.925430372887, 14999.925000375037, 7935.801604959865, 8241.175882411771, 8245.670173193064, 8255.215754503313, 8258.215469530385, 5160.8193713220235, 5308.92036619451, 5416.133418652997, 5533.363663178746, 5533.944660553423, 1916.1951980168362, 1926.8362189213933, 1927.575933294673, 1969.1434226111687, 1982.4449154236693, 25219.747802521924, 25580.488390232276, 26248.0, 26835.731642683517, 26908.865455672596, 6711.697973591103, 6761.154855643044, 6830.658467076626, 6986.999999999898, 7018.052562903943, 17137.91431042837, 17158.656826863393, 17174.0, 17203.22585483656, 17204.827951720323, 7889.289963903277, 7990.240927111915, 8032.39757018226, 8067.112617612058, 8072.152423995513, 7267.091613548307, 7391.704331826774, 7419.0, 7427.108746950401, 7436.66535005926, 5010.924836127461, 5167.638265321391, 5184.196449550326, 5189.325387699575, 5423.647462914898, 1467.0610809082195, 1470.9264536773119, 1471.8601732835364, 1495.439210296139, 1502.4966636176785, 829.1998221716073, 831.8627426474563, 858.0947100808582, 860.8063185783274, 867.5402036920442, 6910.0, 6915.481338899603, 6916.135483064617, 7091.042709234291, 7101.076860008166, 675.4765057080801, 684.6816230452863, 687.9621620810904, 692.6571347183076, 694.4028135803205, 4358.585934336233, 5021.899562008739, 5056.696598204046, 5067.4932506749765, 5128.1794912813775, 20511.8974405127, 20624.0, 21529.892350538146, 21886.562268754536, 21908.0, 20381.694274585596, 20447.4888127798, 20559.38321850347, 20779.79220207809, 20896.37310880676, 9034.2320902724, 9588.232941364675, 10004.749881253027, 10693.41186234749, 10933.234673572933, 7980.92019079825, 8993.325500587613, 9077.137671921157, 9121.498317592595, 9151.77120571991, 18137.0, 18225.633077519506, 18264.45206643803, 18422.90788546049, 18629.44111676652, 18942.52643683919, 19350.0, 19525.414237572895, 19577.80422195817, 19606.705899411805, 10746.08658264025, 10969.957854003856, 10977.615783447542, 11094.500747466545, 11096.833547496633, 13646.727065458437, 13690.86309136896, 13692.3838427273, 13780.448782048607, 13929.930350348184, 10941.179411544324, 11172.385518796544, 11231.831522527333, 11244.26912250701, 11439.199256051996, 10947.34315941046, 10976.396298203676, 11000.119990400588, 11185.944070279596, 11274.436278186222, 9324.393914395543, 9605.615775368908, 9632.614695412105, 9695.951520242354, 9700.417974921527, 6863.210730766026, 6941.375276225164, 7071.7878463646175, 7093.0, 7104.502684812013, 7284.016657751135, 7286.744963926237, 7352.70589176427, 7355.411567074728, 7470.663820128216], "value": 6546.21323861141, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.14199086666844, 515.5154155094211, 515.7859488312349, 523.1211564571519, 524.8215606693724, 6311.842203944898, 6333.968330158343, 6393.680315984194, 6415.133956915821, 6462.2891481937, 6234.719437625306, 6238.968805155979, 6281.623102613847, 6318.557700960934, 6339.809805705825, 5129.666571672848, 5245.085543776513, 5246.658967167122, 5253.4221235664045, 5268.0517506848755, 4871.975640121795, 5195.792168313282, 5249.1601343785005, 5253.44838791927, 5314.601404894629, 4963.1810751226, 4974.850754477371, 5004.199328107504, 5017.071841709278, 5045.4450010499, 4975.477574854661, 4987.825426110105, 5008.549230569248, 5020.548595055337, 5044.470330615288, 4326.58897404746, 4463.732176069446, 4484.775761211927, 4492.236319825637, 4510.534570774942, 6100.786472473442, 6159.3224745277985, 6186.267845003406, 6212.534059945477, 6213.2233470816145, 5757.337906140806, 5780.797672081499, 5792.131180322943, 5796.478316951452, 5823.38854420284, 6667.7666281680395, 6690.7323707051655, 6694.292955296368, 6702.631355275458, 6721.462283017347, 4897.951020489785, 4917.852464426073, 4921.532454416824, 4931.950680493221, 4953.628477864138, 6622.801315960577, 6712.865742685119, 6810.353016463478, 6824.727010919607, 6902.309769023108, 4974.452810190876, 4975.4527002029745, 4981.2030075187795, 4997.0, 5034.993001399735, 5075.11185542536, 5079.517445842639, 5132.101882170605, 5152.433232344439, 5159.380874295109, 5714.885702285931, 5725.627834190765, 5742.712864356766, 5761.049426844524, 5816.185733997244, 6651.201855777338, 6664.400203981665, 6731.124953755981, 6781.491388145909, 6782.118324617768, 1753.9035353055704, 1766.9558261043576, 1774.7160454327245, 1779.67076090921, 1783.7324401339904, 1164.574930150506, 1200.2978257719158, 1207.565276500459, 1216.2884712443142, 1216.4404373988064, 5671.971640141773, 5676.914846277309, 5685.630434021776, 5698.401667824902, 5704.286964129484, 6744.966275168593, 6756.76351327711, 6776.0, 6806.379543875643, 6808.148981377328, 5704.286964129484, 5721.57088218377, 5740.770369185186, 5774.133879918046, 5803.82588522345, 3570.4111670306465, 3576.088097535112, 3589.2462582857893, 3608.891733248007, 3615.1323682316056, 6395.848747225451, 6449.96775016122, 6466.224053113657, 6519.4132528072705, 6541.149650545399, 6775.661216939134, 6882.174139103239, 6912.101426814482, 6924.3421874921805, 6973.19808222061, 6094.238220222473, 6373.7131829066875, 6413.647249401328, 6425.357464253537, 6455.289918109004, 6535.215774107138, 6544.54188206821, 6574.013897915351, 6648.501362397937, 6754.18949726036, 6569.57297775643, 6623.735050597922, 6643.900341494785, 6703.363180497845, 6721.193456785217, 6566.946369938002, 6576.704048317933, 6589.439897608565, 6607.768728094494, 6674.365935236145, 4989.825356112518, 5008.348914641073, 5012.799488020584, 5064.518870707277, 5088.287639730367, 6570.901436478553, 6706.631135287606, 6743.2582415935185, 6883.27725588806, 6907.551009184387, 6423.9036414452885, 6514.967425162844, 6517.217933847968, 6541.934580654132, 6605.853097743348, 6504.642244676399, 6504.642244676588, 6539.70571324282, 6561.1470508833545, 6574.441172500391, 6385.393387628168, 6480.0, 6512.0, 6520.902186467301, 6579.703913324008, 6592.17597800275, 6618.7352505899225, 6643.933560664332, 6709.496787740842, 6720.294369091371, 6273.529485288713, 6387.904181437189, 6446.871062578628, 6470.482361410982, 6495.9281718517805], "value": 5088.729950363967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.6274845938932, 908.9681861134859, 924.3529529329471, 928.3965422475391, 928.8049509602984, 18520.444386668405, 19338.419847404566, 19355.806441935594, 19364.225430982744, 19416.22335106594, 17513.0, 17531.2110955007, 17548.0, 17620.82379176211, 17738.467845964642, 945.3524335829944, 970.3741086998881, 972.4262685015839, 974.2644303550809, 975.9463229522373, 981.0973904008293, 984.148711364668, 984.1929617713442, 985.0199051943326, 985.3644399362407, 991.5637119667359, 1030.2942484398175, 1034.0280136671543, 1037.4138611684375, 1039.8544203811473, 1021.7956408718286, 1024.3085917006065, 1027.5273374247893, 1028.9897101028969, 1030.845373194023, 728.9854202915965, 747.8317378589828, 749.0711517718045, 752.3943225703307, 753.7399597138979, 19378.418647440598, 19488.610227795507, 19519.316823911096, 19544.31594894186, 19574.902125489425, 21111.68332475014, 21145.15419383223, 22127.225547105936, 22342.10631574735, 22384.328470145923, 17497.912510437494, 17684.115794210236, 17788.0, 17874.731879021823, 17917.910410447865, 3785.716071294664, 3815.0, 3815.67566756826, 3817.064819119306, 3821.159344944108, 101489.0, 132658.3367083168, 136181.0, 136329.0, 136658.31670841682, 16664.250108745135, 17185.570360741083, 17254.913725431292, 17276.65446691059, 17290.481285561455, 30769.846150769103, 31074.378512430078, 31531.684683153333, 31787.0, 31796.20509487235, 9018.413803102778, 9018.819623607491, 9024.909750902538, 9067.727968160965, 9094.81810363789, 4072.205919845661, 4080.9183816323507, 4164.7917604120275, 4165.229432554987, 4183.769892655933, 5334.093204155303, 5402.297701298885, 5407.70257635826, 5441.374241962225, 5442.863928401822, 1077.0414331245197, 1088.6733979806027, 1105.9778804424027, 1114.6266000889793, 1115.0132133062298, 696.923338432772, 707.8265824872939, 715.9797288863452, 720.045939130654, 729.6534146280475, 12199.451024703909, 12684.0, 13018.739625207443, 13028.54400095992, 13231.404586793617, 668.7926742709775, 679.0832376292065, 682.9112215411965, 685.8491131950963, 692.0933577014027, 5439.184122381675, 5541.750621222055, 5553.722313884289, 5557.333120025542, 5666.546676265889, 125561.37219314028, 126339.0, 128271.0, 130216.3489182567, 131965.0, 107833.0, 110108.4494577522, 110182.0, 113280.0, 117551.41224293824, 95821.52089239508, 97133.0, 98131.0, 98158.5092074535, 98742.5062874681, 10306.793864122526, 10413.219008574539, 10418.583256669648, 10644.308119972176, 10832.18758593093, 44180.337294939956, 44202.3369649462, 45076.549234507234, 46898.765506173615, 47178.52821471879, 58264.708676458045, 59411.70294148502, 59577.40422595892, 60680.0, 60768.696156518934, 14915.552533424014, 15337.6165595861, 15348.693026139192, 15534.533963981099, 15559.533214003599, 16535.83464165343, 16802.24389902482, 16856.325746969986, 16946.915265423595, 16960.151992400082, 15621.531354059396, 15635.76546351783, 15791.763123553386, 15881.364745410516, 16030.759538606697, 15427.382904683687, 15571.76642350343, 15711.292991815168, 15742.685146297239, 15767.0, 15525.611859703598, 15664.060156390653, 15766.369345226063, 15775.447859324868, 15831.604209894846, 10834.0, 10907.509162087883, 11022.669319920415, 11250.0, 11250.943745281222, 11830.349330786888, 11930.701732456759, 12037.277763333877, 12069.27584344942, 12237.265764054186], "value": 8960.022314578646, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1416.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 108.0, 108.0, 108.0, 106.0, 106.0, 108.0, 109.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 120.0, 115.0, 125.0, 115.0, 145.0, 117.0, 122.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 163.0, 164.0, 163.0, 163.0, 165.0, 169.0, 166.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 74.0, 74.0, 75.0, 74.0, 76.0, 75.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 79.0, 80.0, 80.0, 81.0, 80.0, 80.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 114.0, 113.0, 114.0, 114.0, 114.0, 117.0, 113.0, 117.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 100.0, 99.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 56.0, 53.0, 54.0, 55.0, 60.0, 54.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0], "value": 37.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 74.0, 75.0, 74.0, 75.0, 73.0, 74.0, 76.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 113.0, 110.0, 117.0, 107.0, 115.0, 108.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 167.0, 165.0, 168.0, 176.0, 165.0, 169.0, 167.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 65.0, 65.0, 67.0, 64.0, 65.0, 70.0, 66.0], "value": 65.9, "unit": "score"}]}]} 11:44:54 INFO - Return code: 0 11:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:54 INFO - # TBPL SUCCESS # 11:44:54 INFO - Running post-action listener: _package_coverage_data 11:44:54 INFO - Running post-action listener: _resource_record_post_action 11:44:54 INFO - [mozharness: 2017-09-18 18:44:54.341104Z] Finished run-tests step (success) 11:44:54 INFO - Running post-run listener: _resource_record_post_run 11:44:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 339730432; Read time: 16; Write time: 193380 11:44:54 INFO - TinderboxPrint: CPU usage
13.1% 11:44:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:44:54 INFO - TinderboxPrint: I/O write bytes / time
339,730,432 / 193,380 11:44:54 INFO - TinderboxPrint: CPU idle
8,234.6 (86.9%) 11:44:54 INFO - TinderboxPrint: CPU user
1,192.7 (12.6%) 11:44:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13107200; Read time: 0; Write time: 1456 11:44:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:44:54 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 326623232; Read time: 0; Write time: 191924 11:44:54 INFO - Running post-run listener: _upload_blobber_files 11:44:54 INFO - Blob upload gear active. 11:44:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:54 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 11:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:56 INFO - (blobuploader) - INFO - Done attempting. 11:44:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:57 INFO - (blobuploader) - INFO - Done attempting. 11:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:01 INFO - (blobuploader) - INFO - Done attempting. 11:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:02 INFO - (blobuploader) - INFO - Done attempting. 11:45:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:02 INFO - Return code: 0 11:45:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c78f62534e6d369eddc580590a01a6adaa1390f9664da1d7a4b888e044512f6e079a21cfc048f663d467ad0b398c68ee97c4f1edc1481c245329c46bd266ee", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d6eb7b987bc2fd64666e81703cd37300c497e2895cbf0ca1eb3be566a00557cd6f6845bad718296bc847968189397c02abe2e3b62be5f1345c001fc65506d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e5c7ba9a4af404df45cd09918b9e2cbff2960f9ce4d54674569708291ad12fa43098927c90ae291d5be9b860a80b8a3576ead922a4625d2f9b05bef535b0661", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0dec43b954b5f854900998c511727d5ae97a709e3f341fbf66ad936419969768fe67a1df4e1e41628e4e04d251a4019a5e5e10cbc830fe4e0d4109befdef2da"} 11:45:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:02 INFO - Contents: 11:45:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c78f62534e6d369eddc580590a01a6adaa1390f9664da1d7a4b888e044512f6e079a21cfc048f663d467ad0b398c68ee97c4f1edc1481c245329c46bd266ee", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d6eb7b987bc2fd64666e81703cd37300c497e2895cbf0ca1eb3be566a00557cd6f6845bad718296bc847968189397c02abe2e3b62be5f1345c001fc65506d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e5c7ba9a4af404df45cd09918b9e2cbff2960f9ce4d54674569708291ad12fa43098927c90ae291d5be9b860a80b8a3576ead922a4625d2f9b05bef535b0661", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0dec43b954b5f854900998c511727d5ae97a709e3f341fbf66ad936419969768fe67a1df4e1e41628e4e04d251a4019a5e5e10cbc830fe4e0d4109befdef2da"} 11:45:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:02 INFO - Copying logs to upload dir... 11:45:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.881292 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-18 11:45:02.588156) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:02.595993) ========= 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=41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c78f62534e6d369eddc580590a01a6adaa1390f9664da1d7a4b888e044512f6e079a21cfc048f663d467ad0b398c68ee97c4f1edc1481c245329c46bd266ee", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d6eb7b987bc2fd64666e81703cd37300c497e2895cbf0ca1eb3be566a00557cd6f6845bad718296bc847968189397c02abe2e3b62be5f1345c001fc65506d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e5c7ba9a4af404df45cd09918b9e2cbff2960f9ce4d54674569708291ad12fa43098927c90ae291d5be9b860a80b8a3576ead922a4625d2f9b05bef535b0661", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0dec43b954b5f854900998c511727d5ae97a709e3f341fbf66ad936419969768fe67a1df4e1e41628e4e04d251a4019a5e5e10cbc830fe4e0d4109befdef2da"} build_url:https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/SnPiQaAJQmqSN7jo34Jbdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/31c78f62534e6d369eddc580590a01a6adaa1390f9664da1d7a4b888e044512f6e079a21cfc048f663d467ad0b398c68ee97c4f1edc1481c245329c46bd266ee", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa1d6eb7b987bc2fd64666e81703cd37300c497e2895cbf0ca1eb3be566a00557cd6f6845bad718296bc847968189397c02abe2e3b62be5f1345c001fc65506d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e5c7ba9a4af404df45cd09918b9e2cbff2960f9ce4d54674569708291ad12fa43098927c90ae291d5be9b860a80b8a3576ead922a4625d2f9b05bef535b0661", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0dec43b954b5f854900998c511727d5ae97a709e3f341fbf66ad936419969768fe67a1df4e1e41628e4e04d251a4019a5e5e10cbc830fe4e0d4109befdef2da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:02.627664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:02.628121) ========= 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=41bf3e9aed84707956354da8000001c5-1505754906.791173-764599932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:45:02.709735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 11:45:02.710069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 11:45:02.710400) ========= ========= Total master_lag: 0.27 =========