builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-072 starttime: 1504290837.02 results: success (0) revision: d1292636950a4ac1bb818cf05b113e3fcd6babe1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.018753) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.019365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.019804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.039062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.039490) ========= 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=199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 11:33:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-09-01 11:33:57 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.182058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.182601) ========= 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=199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:57.233247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 11:33:57.233704) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1292636950a4ac1bb818cf05b113e3fcd6babe1 --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 d1292636950a4ac1bb818cf05b113e3fcd6babe1 --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=199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 11:33:57,256 truncating revision to first 12 chars 2017-09-01 11:33:57,256 Setting DEBUG logging. 2017-09-01 11:33:57,256 attempt 1/10 2017-09-01 11:33:57,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1292636950a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 11:33:58,551 unpacking tar archive at: mozilla-central-d1292636950a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.665160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 11:33:58.916090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:58.916643) ========= script_repo_revision: d1292636950a4ac1bb818cf05b113e3fcd6babe1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:58.917270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:58.917734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 11:33:58.933436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-01 11:33:58.933966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:59 INFO - MultiFileLogger online at 20170901 11:33:59 in /builds/slave/test 11:33:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:33:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:59 INFO - {'append_to_log': False, 11:33:59 INFO - 'base_work_dir': '/builds/slave/test', 11:33:59 INFO - 'blob_upload_branch': 'Firefox', 11:33:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:59 INFO - 'branch': 'Firefox', 11:33:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:59 INFO - 'code_coverage': False, 11:33:59 INFO - 'config_files': ('talos/linux_config.py',), 11:33:59 INFO - 'default_actions': ('clobber', 11:33:59 INFO - 'read-buildbot-config', 11:33:59 INFO - 'download-and-extract', 11:33:59 INFO - 'populate-webroot', 11:33:59 INFO - 'create-virtualenv', 11:33:59 INFO - 'install', 11:33:59 INFO - 'setup-mitmproxy', 11:33:59 INFO - 'run-tests'), 11:33:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:59 INFO - 'disable_ccov_upload': False, 11:33:59 INFO - 'disable_stylo': False, 11:33:59 INFO - 'download_minidump_stackwalk': True, 11:33:59 INFO - 'download_symbols': 'ondemand', 11:33:59 INFO - 'enable_stylo': False, 11:33:59 INFO - 'enable_webrender': False, 11:33:59 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:33:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:59 INFO - 'gecko_profile': False, 11:33:59 INFO - 'gecko_profile_interval': 0, 11:33:59 INFO - 'installer_path': 'installer.exe', 11:33:59 INFO - 'log_level': 'info', 11:33:59 INFO - 'log_name': 'talos', 11:33:59 INFO - 'log_to_console': True, 11:33:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:59 INFO - 'opt_config_files': (), 11:33:59 INFO - 'pip_index': False, 11:33:59 INFO - 'suite': 'dromaeojs-e10s', 11:33:59 INFO - 'system_bits': '32', 11:33:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:59 INFO - 'title': 'talos-linux64-ix-072', 11:33:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:59 INFO - 'use_talos_json': True, 11:33:59 INFO - 'verify': 'False', 11:33:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:59 INFO - 'work_dir': 'build'} 11:33:59 INFO - [mozharness: 2017-09-01 18:33:59.097036Z] Running clobber step. 11:33:59 INFO - Running pre-action listener: _resource_record_pre_action 11:33:59 INFO - Running main action method: clobber 11:33:59 INFO - rmtree: /builds/slave/test/build 11:33:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:34:00 INFO - Running post-action listener: _resource_record_post_action 11:34:00 INFO - [mozharness: 2017-09-01 18:34:00.099132Z] Finished clobber step (success) 11:34:00 INFO - [mozharness: 2017-09-01 18:34:00.099228Z] Running read-buildbot-config step. 11:34:00 INFO - Running pre-action listener: _resource_record_pre_action 11:34:00 INFO - Running main action method: read_buildbot_config 11:34:00 INFO - Using buildbot properties: 11:34:00 INFO - { 11:34:00 INFO - "project": "", 11:34:00 INFO - "product": "firefox", 11:34:00 INFO - "who": "ffxbld@noreply.mozilla.org", 11:34:00 INFO - "installer_path": "public/build/target.tar.bz2", 11:34:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:34:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:34:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:34:00 INFO - "stage_platform": "linux64-pgo", 11:34:00 INFO - "basedir": "/builds/slave/test", 11:34:00 INFO - "buildnumber": 150, 11:34:00 INFO - "platform": "ubuntu64_hw", 11:34:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:34:00 INFO - "slavebuilddir": "test", 11:34:00 INFO - "taskId": "HyQwyWZLSUSSBLaP4RMZDQ", 11:34:00 INFO - "branch": "mozilla-central", 11:34:00 INFO - "script_repo_revision": "production", 11:34:00 INFO - "revision": "d1292636950a4ac1bb818cf05b113e3fcd6babe1", 11:34:00 INFO - "slavename": "talos-linux64-ix-072", 11:34:00 INFO - "repo_path": "mozilla-central" 11:34:00 INFO - } 11:34:00 INFO - Finding installer, test and symbols from parent task. 11:34:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HyQwyWZLSUSSBLaP4RMZDQ'}, attempt #1 11:34:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HyQwyWZLSUSSBLaP4RMZDQ'}, attempt #1 11:34:01 INFO - Task dependencies: c7Rs-MIYRLm3AsKapwL0Sw 11:34:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw'}, attempt #1 11:34:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2 11:34:01 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.test_packages.json 11:34:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.crashreporter-symbols.zip 11:34:01 INFO - Running post-action listener: _resource_record_post_action 11:34:01 INFO - [mozharness: 2017-09-01 18:34:01.486229Z] Finished read-buildbot-config step (success) 11:34:01 INFO - [mozharness: 2017-09-01 18:34:01.486444Z] Running download-and-extract step. 11:34:01 INFO - Running pre-action listener: _resource_record_pre_action 11:34:01 INFO - Running main action method: download_and_extract 11:34:01 INFO - mkdir: /builds/slave/test/build/tests 11:34:01 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:34:01 INFO - trying https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.test_packages.json 11:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:34:02 INFO - Downloaded 989 bytes. 11:34:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:34:02 INFO - Using the following test package requirements: 11:34:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:34:02 INFO - u'common': [u'target.common.tests.zip'], 11:34:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:34:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:34:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:34:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:34:02 INFO - u'mozbase': [u'target.common.tests.zip'], 11:34:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:34:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:34:02 INFO - u'web-platform': [u'target.common.tests.zip', 11:34:02 INFO - u'target.web-platform.tests.tar.gz'], 11:34:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:34:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.common.tests.zip 11:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.common.tests.zip into memory 11:34:03 INFO - Content-Length response header: 55584389 11:34:03 INFO - Bytes received: 55584389 11:34:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:34:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.common.tests.zip 11:34:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:34:14 INFO - Fetch https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.common.tests.zip into memory 11:34:15 INFO - Content-Length response header: 55584389 11:34:15 INFO - Bytes received: 55584389 11:34:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.talos.tests.zip 11:34:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:34:27 INFO - Fetch https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.talos.tests.zip into memory 11:34:28 INFO - Content-Length response header: 14496650 11:34:28 INFO - Bytes received: 14496650 11:34:28 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:34:28 INFO - trying https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2 11:34:28 INFO - Downloading https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:34:29 INFO - Downloaded 63360172 bytes. 11:34:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2 11:34:29 INFO - mkdir: /builds/slave/test/properties 11:34:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:34:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:34:29 INFO - Contents: 11:34:29 INFO - build_url:https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2 11:34:29 INFO - Running post-action listener: _resource_record_post_action 11:34:29 INFO - Running post-action listener: find_tests_for_verification 11:34:29 INFO - Running post-action listener: set_extra_try_arguments 11:34:29 INFO - [mozharness: 2017-09-01 18:34:29.882824Z] Finished download-and-extract step (success) 11:34:29 INFO - [mozharness: 2017-09-01 18:34:29.882921Z] Running populate-webroot step. 11:34:29 INFO - Running pre-action listener: _resource_record_pre_action 11:34:29 INFO - Running main action method: populate_webroot 11:34:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:34:29 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:34:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:34:29 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:34:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:29 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:34:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'tests': ['damp', 'tps']}, 11:34:29 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['damp', 'tps']}, 11:34:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:34:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:34:29 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:34:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:34:29 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:34:29 INFO - 'other-e10s': {'tests': ['a11yr', 11:34:29 INFO - 'ts_paint', 11:34:29 INFO - 'tpaint', 11:34:29 INFO - 'sessionrestore', 11:34:29 INFO - 'sessionrestore_many_windows', 11:34:29 INFO - 'sessionrestore_no_auto_restore', 11:34:29 INFO - 'tabpaint']}, 11:34:29 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['a11yr', 11:34:29 INFO - 'ts_paint', 11:34:29 INFO - 'tpaint', 11:34:29 INFO - 'sessionrestore', 11:34:29 INFO - 'sessionrestore_many_windows', 11:34:29 INFO - 'sessionrestore_no_auto_restore', 11:34:29 INFO - 'tabpaint']}, 11:34:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:34:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:34:29 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['bloom_basic_singleton']}, 11:34:29 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['bloom_basic']}, 11:34:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:34:29 INFO - 'tsvgr_opacity', 11:34:29 INFO - 'tart', 11:34:29 INFO - 'tscrollx', 11:34:29 INFO - 'tsvg_static']}, 11:34:29 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['tsvgx', 11:34:29 INFO - 'tsvgr_opacity', 11:34:29 INFO - 'tart', 11:34:29 INFO - 'tscrollx', 11:34:29 INFO - 'tsvg_static']}, 11:34:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:34:29 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo'], 11:34:29 INFO - 'tests': ['tp5o']}, 11:34:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:34:29 INFO - 'talos_options': ['--mitmproxy', 11:34:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:34:29 INFO - '--firstNonBlankPaint'], 11:34:29 INFO - 'tests': ['tp6_google', 11:34:29 INFO - 'tp6_youtube', 11:34:29 INFO - 'tp6_amazon', 11:34:29 INFO - 'tp6_facebook']}, 11:34:29 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo', 11:34:29 INFO - '--mitmproxy', 11:34:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:34:29 INFO - '--firstNonBlankPaint'], 11:34:29 INFO - 'tests': ['tp6_google', 11:34:29 INFO - 'tp6_youtube', 11:34:29 INFO - 'tp6_amazon', 11:34:29 INFO - 'tp6_facebook']}, 11:34:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo', 11:34:29 INFO - '--stylo-threads=1', 11:34:29 INFO - '--mitmproxy', 11:34:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:34:29 INFO - '--firstNonBlankPaint'], 11:34:29 INFO - 'tests': ['tp6_google', 11:34:29 INFO - 'tp6_youtube', 11:34:29 INFO - 'tp6_amazon', 11:34:29 INFO - 'tp6_facebook']}, 11:34:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'talos_options': ['--xperf_path', 11:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:29 INFO - 'tests': ['tp5n']}, 11:34:29 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:34:29 INFO - 'talos_options': ['--enable-stylo', 11:34:29 INFO - '--xperf_path', 11:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:34:29 INFO - 'tests': ['tp5n']}}} 11:34:29 INFO - Running post-action listener: _resource_record_post_action 11:34:29 INFO - [mozharness: 2017-09-01 18:34:29.897051Z] Finished populate-webroot step (success) 11:34:29 INFO - [mozharness: 2017-09-01 18:34:29.897139Z] Running create-virtualenv step. 11:34:29 INFO - Running pre-action listener: _resource_record_pre_action 11:34:29 INFO - Running main action method: create_virtualenv 11:34:29 INFO - Creating virtualenv /builds/slave/test/build/venv 11:34:29 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:34:29 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:34:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:34:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:34:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:34:30 INFO - Installing distribute.............................................................................................................................................................................................done. 11:34:30 INFO - Installing pip...............done. 11:34:30 INFO - Return code: 0 11:34:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:34:30 INFO - Reading from file tmpfile_stdout 11:34:30 INFO - Output received: 11:34:30 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:34:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:34:30 INFO - Using env: {'DISPLAY': ':0', 11:34:30 INFO - 'HOME': '/home/cltbld', 11:34:30 INFO - 'LANG': 'en_US.UTF-8', 11:34:30 INFO - 'LANGUAGE': 'en_US:en', 11:34:30 INFO - 'LOGNAME': 'cltbld', 11:34:30 INFO - 'MAIL': '/var/mail/cltbld', 11:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:30 INFO - 'MOZ_NO_REMOTE': '1', 11:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:30 INFO - 'NO_EM_RESTART': '1', 11:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:30 INFO - 'PWD': '/builds/slave/test', 11:34:30 INFO - 'SHELL': '/bin/bash', 11:34:30 INFO - 'SHLVL': '1', 11:34:30 INFO - 'TERM': 'linux', 11:34:30 INFO - 'TMOUT': '86400', 11:34:30 INFO - 'USER': 'cltbld', 11:34:30 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:30 INFO - '_': '/tools/buildbot/bin/python'} 11:34:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:34:32 INFO - Downloading/unpacking pip>=1.5 11:34:32 INFO - Running setup.py egg_info for package pip 11:34:32 INFO - warning: no files found matching 'pip/cacert.pem' 11:34:32 INFO - warning: no files found matching '*.html' under directory 'docs' 11:34:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:34:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:34:32 INFO - Installing collected packages: pip 11:34:32 INFO - Found existing installation: pip 1.1 11:34:32 INFO - Uninstalling pip: 11:34:32 INFO - Successfully uninstalled pip 11:34:32 INFO - Running setup.py install for pip 11:34:32 INFO - warning: no files found matching 'pip/cacert.pem' 11:34:32 INFO - warning: no files found matching '*.html' under directory 'docs' 11:34:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:34:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:34:32 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:34:32 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:34:32 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:34:32 INFO - Successfully installed pip 11:34:32 INFO - Cleaning up... 11:34:32 INFO - Return code: 0 11:34:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:32 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:32 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:34:32 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:34:32 INFO - Using env: {'DISPLAY': ':0', 11:34:32 INFO - 'HOME': '/home/cltbld', 11:34:32 INFO - 'LANG': 'en_US.UTF-8', 11:34:32 INFO - 'LANGUAGE': 'en_US:en', 11:34:32 INFO - 'LOGNAME': 'cltbld', 11:34:32 INFO - 'MAIL': '/var/mail/cltbld', 11:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:32 INFO - 'MOZ_NO_REMOTE': '1', 11:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:32 INFO - 'NO_EM_RESTART': '1', 11:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:32 INFO - 'PWD': '/builds/slave/test', 11:34:32 INFO - 'SHELL': '/bin/bash', 11:34:32 INFO - 'SHLVL': '1', 11:34:32 INFO - 'TERM': 'linux', 11:34:32 INFO - 'TMOUT': '86400', 11:34:32 INFO - 'USER': 'cltbld', 11:34:32 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:32 INFO - '_': '/tools/buildbot/bin/python'} 11:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:32 INFO - Downloading/unpacking psutil>=3.1.1 11:34:32 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:34:32 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:34:32 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:34:32 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:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:33 INFO - Installing collected packages: psutil 11:34:33 INFO - Running setup.py install for psutil 11:34:33 INFO - building 'psutil._psutil_linux' extension 11:34:33 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:34:33 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:34:33 INFO - building 'psutil._psutil_posix' extension 11:34:33 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:34:33 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:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:34:34 INFO - Successfully installed psutil 11:34:34 INFO - Cleaning up... 11:34:34 INFO - Return code: 0 11:34:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:34 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:34 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:34:34 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:34:34 INFO - Using env: {'DISPLAY': ':0', 11:34:34 INFO - 'HOME': '/home/cltbld', 11:34:34 INFO - 'LANG': 'en_US.UTF-8', 11:34:34 INFO - 'LANGUAGE': 'en_US:en', 11:34:34 INFO - 'LOGNAME': 'cltbld', 11:34:34 INFO - 'MAIL': '/var/mail/cltbld', 11:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:34 INFO - 'MOZ_NO_REMOTE': '1', 11:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:34 INFO - 'NO_EM_RESTART': '1', 11:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:34 INFO - 'PWD': '/builds/slave/test', 11:34:34 INFO - 'SHELL': '/bin/bash', 11:34:34 INFO - 'SHLVL': '1', 11:34:34 INFO - 'TERM': 'linux', 11:34:34 INFO - 'TMOUT': '86400', 11:34:34 INFO - 'USER': 'cltbld', 11:34:34 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:34 INFO - '_': '/tools/buildbot/bin/python'} 11:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:34:34 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:34:34 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:34:34 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:34:34 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:34:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:34:35 INFO - Installing collected packages: mozsystemmonitor 11:34:35 INFO - Running setup.py install for mozsystemmonitor 11:34:35 INFO - Successfully installed mozsystemmonitor 11:34:35 INFO - Cleaning up... 11:34:35 INFO - Return code: 0 11:34:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:34:35 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:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:35 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:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:35 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:35 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:34:35 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:34:35 INFO - Using env: {'DISPLAY': ':0', 11:34:35 INFO - 'HOME': '/home/cltbld', 11:34:35 INFO - 'LANG': 'en_US.UTF-8', 11:34:35 INFO - 'LANGUAGE': 'en_US:en', 11:34:35 INFO - 'LOGNAME': 'cltbld', 11:34:35 INFO - 'MAIL': '/var/mail/cltbld', 11:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:35 INFO - 'MOZ_NO_REMOTE': '1', 11:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:35 INFO - 'NO_EM_RESTART': '1', 11:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:35 INFO - 'PWD': '/builds/slave/test', 11:34:35 INFO - 'SHELL': '/bin/bash', 11:34:35 INFO - 'SHLVL': '1', 11:34:35 INFO - 'TERM': 'linux', 11:34:35 INFO - 'TMOUT': '86400', 11:34:35 INFO - 'USER': 'cltbld', 11:34:35 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:35 INFO - '_': '/tools/buildbot/bin/python'} 11:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:35 INFO - Downloading/unpacking jsonschema==2.5.1 11:34:35 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:34:35 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:34:35 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:34:35 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:34:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:34:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:34:36 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:34:36 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:34:36 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:34:36 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:34:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:34:37 INFO - warning: no files found matching '*.txt' 11:34:37 INFO - no previously-included directories found matching 'build' 11:34:37 INFO - no previously-included directories found matching 'dist' 11:34:37 INFO - no previously-included directories found matching '.git*' 11:34:37 INFO - Installing collected packages: jsonschema, functools32 11:34:37 INFO - Running setup.py install for functools32 11:34:37 INFO - warning: no files found matching '*.txt' 11:34:37 INFO - no previously-included directories found matching 'build' 11:34:37 INFO - no previously-included directories found matching 'dist' 11:34:37 INFO - no previously-included directories found matching '.git*' 11:34:37 INFO - Successfully installed jsonschema functools32 11:34:37 INFO - Cleaning up... 11:34:37 INFO - Return code: 0 11:34:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:34:37 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:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:37 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:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:37 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:37 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:34:37 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:34:37 INFO - Using env: {'DISPLAY': ':0', 11:34:37 INFO - 'HOME': '/home/cltbld', 11:34:37 INFO - 'LANG': 'en_US.UTF-8', 11:34:37 INFO - 'LANGUAGE': 'en_US:en', 11:34:37 INFO - 'LOGNAME': 'cltbld', 11:34:37 INFO - 'MAIL': '/var/mail/cltbld', 11:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:37 INFO - 'MOZ_NO_REMOTE': '1', 11:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:37 INFO - 'NO_EM_RESTART': '1', 11:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:37 INFO - 'PWD': '/builds/slave/test', 11:34:37 INFO - 'SHELL': '/bin/bash', 11:34:37 INFO - 'SHLVL': '1', 11:34:37 INFO - 'TERM': 'linux', 11:34:37 INFO - 'TMOUT': '86400', 11:34:37 INFO - 'USER': 'cltbld', 11:34:37 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:37 INFO - '_': '/tools/buildbot/bin/python'} 11:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:34:37 INFO - Cleaning up... 11:34:37 INFO - Return code: 0 11:34:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:34:37 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:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:37 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:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:37 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:37 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:34:37 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:34:37 INFO - Using env: {'DISPLAY': ':0', 11:34:37 INFO - 'HOME': '/home/cltbld', 11:34:37 INFO - 'LANG': 'en_US.UTF-8', 11:34:37 INFO - 'LANGUAGE': 'en_US:en', 11:34:37 INFO - 'LOGNAME': 'cltbld', 11:34:37 INFO - 'MAIL': '/var/mail/cltbld', 11:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:37 INFO - 'MOZ_NO_REMOTE': '1', 11:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:37 INFO - 'NO_EM_RESTART': '1', 11:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:37 INFO - 'PWD': '/builds/slave/test', 11:34:37 INFO - 'SHELL': '/bin/bash', 11:34:37 INFO - 'SHLVL': '1', 11:34:37 INFO - 'TERM': 'linux', 11:34:37 INFO - 'TMOUT': '86400', 11:34:37 INFO - 'USER': 'cltbld', 11:34:37 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:37 INFO - '_': '/tools/buildbot/bin/python'} 11:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:34:37 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:34:37 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:34:37 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:34:37 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:34:38 INFO - Downloading blobuploader-1.2.4.tar.gz 11:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:34:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:34:38 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:34:38 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:34:38 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:34:38 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:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:34:39 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:34:39 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:34:39 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:34:39 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:34:39 INFO - Downloading docopt-0.6.1.tar.gz 11:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:34:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:34:39 INFO - Running setup.py install for blobuploader 11:34:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:34:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:34:39 INFO - Running setup.py install for requests 11:34:39 INFO - Running setup.py install for docopt 11:34:39 INFO - Successfully installed blobuploader requests docopt 11:34:39 INFO - Cleaning up... 11:34:39 INFO - Return code: 0 11:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:39 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:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:39 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:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:39 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:39 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:34:39 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:34:39 INFO - Using env: {'DISPLAY': ':0', 11:34:39 INFO - 'HOME': '/home/cltbld', 11:34:39 INFO - 'LANG': 'en_US.UTF-8', 11:34:39 INFO - 'LANGUAGE': 'en_US:en', 11:34:39 INFO - 'LOGNAME': 'cltbld', 11:34:39 INFO - 'MAIL': '/var/mail/cltbld', 11:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:39 INFO - 'MOZ_NO_REMOTE': '1', 11:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:39 INFO - 'NO_EM_RESTART': '1', 11:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:39 INFO - 'PWD': '/builds/slave/test', 11:34:39 INFO - 'SHELL': '/bin/bash', 11:34:39 INFO - 'SHLVL': '1', 11:34:39 INFO - 'TERM': 'linux', 11:34:39 INFO - 'TMOUT': '86400', 11:34:39 INFO - 'USER': 'cltbld', 11:34:39 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:39 INFO - '_': '/tools/buildbot/bin/python'} 11:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:40 INFO - Running setup.py (path:/tmp/pip-X0ZxUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:40 INFO - Running setup.py (path:/tmp/pip-sMxvAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:40 INFO - Running setup.py (path:/tmp/pip-CJ_LQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:40 INFO - Running setup.py (path:/tmp/pip-Nq7Luo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:40 INFO - Running setup.py (path:/tmp/pip-Yc8DAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:40 INFO - Running setup.py (path:/tmp/pip-8ZZw07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:40 INFO - Running setup.py (path:/tmp/pip-0cIEcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:40 INFO - Running setup.py (path:/tmp/pip-5z00xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:40 INFO - Running setup.py (path:/tmp/pip-IaGUMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:40 INFO - Running setup.py (path:/tmp/pip-gQ0i6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:40 INFO - Running setup.py (path:/tmp/pip-qWnLED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:40 INFO - Running setup.py (path:/tmp/pip-pPRLco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:40 INFO - Running setup.py (path:/tmp/pip-eNvNme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:41 INFO - Running setup.py (path:/tmp/pip-uopxrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:41 INFO - Running setup.py (path:/tmp/pip-adUZXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:41 INFO - Running setup.py (path:/tmp/pip-KJSmQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:41 INFO - Running setup.py (path:/tmp/pip-4_F37a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:34:41 INFO - Running setup.py install for manifestparser 11:34:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:34:41 INFO - Running setup.py install for mozcrash 11:34:41 INFO - Running setup.py install for mozdebug 11:34:41 INFO - Running setup.py install for mozdevice 11:34:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:34:41 INFO - Running setup.py install for mozfile 11:34:41 INFO - Running setup.py install for mozhttpd 11:34:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:34:41 INFO - Running setup.py install for mozinfo 11:34:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Running setup.py install for mozInstall 11:34:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Running setup.py install for mozleak 11:34:42 INFO - Running setup.py install for mozlog 11:34:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Running setup.py install for moznetwork 11:34:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Running setup.py install for mozprocess 11:34:42 INFO - Running setup.py install for mozprofile 11:34:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Running setup.py install for mozrunner 11:34:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:34:42 INFO - Running setup.py install for mozscreenshot 11:34:42 INFO - Running setup.py install for moztest 11:34:42 INFO - Running setup.py install for mozversion 11:34:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:34:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:34:43 INFO - Cleaning up... 11:34:43 INFO - Return code: 0 11:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34: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:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34: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:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:43 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:43 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:34:43 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:34:43 INFO - Using env: {'DISPLAY': ':0', 11:34:43 INFO - 'HOME': '/home/cltbld', 11:34:43 INFO - 'LANG': 'en_US.UTF-8', 11:34:43 INFO - 'LANGUAGE': 'en_US:en', 11:34:43 INFO - 'LOGNAME': 'cltbld', 11:34:43 INFO - 'MAIL': '/var/mail/cltbld', 11:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:43 INFO - 'MOZ_NO_REMOTE': '1', 11:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:43 INFO - 'NO_EM_RESTART': '1', 11:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:43 INFO - 'PWD': '/builds/slave/test', 11:34:43 INFO - 'SHELL': '/bin/bash', 11:34:43 INFO - 'SHLVL': '1', 11:34:43 INFO - 'TERM': 'linux', 11:34:43 INFO - 'TMOUT': '86400', 11:34:43 INFO - 'USER': 'cltbld', 11:34:43 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:43 INFO - '_': '/tools/buildbot/bin/python'} 11:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:34:43 INFO - Running setup.py (path:/tmp/pip-kdRX_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:34:43 INFO - Running setup.py (path:/tmp/pip-g_hFBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:34:43 INFO - Running setup.py (path:/tmp/pip-gq4a8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:34:43 INFO - Running setup.py (path:/tmp/pip-6rCnTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:34:43 INFO - Running setup.py (path:/tmp/pip-mhlndY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:34:43 INFO - Running setup.py (path:/tmp/pip-4M5zNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:34:43 INFO - Running setup.py (path:/tmp/pip-IOPYdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:34:43 INFO - Running setup.py (path:/tmp/pip-xOMcBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:34:43 INFO - Running setup.py (path:/tmp/pip-f8FyGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:34:43 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:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:34:43 INFO - Running setup.py (path:/tmp/pip-UBFaPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:34:44 INFO - Running setup.py (path:/tmp/pip-fx_VkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:34:44 INFO - Running setup.py (path:/tmp/pip-k_0ie_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:34:44 INFO - Running setup.py (path:/tmp/pip-aElmB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:34:44 INFO - Running setup.py (path:/tmp/pip-BAG8Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:44 INFO - Running setup.py (path:/tmp/pip-QYi3iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:34:44 INFO - Running setup.py (path:/tmp/pip-F5brpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:34:44 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:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:34:44 INFO - Running setup.py (path:/tmp/pip-1utaq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 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:34:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:34:44 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:34:44 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:34:44 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:34:44 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:34:45 INFO - Downloading blessings-1.6.tar.gz 11:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:34:45 INFO - Installing collected packages: blessings 11:34:45 INFO - Running setup.py install for blessings 11:34:45 INFO - Successfully installed blessings 11:34:45 INFO - Cleaning up... 11:34:45 INFO - Return code: 0 11:34:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:46 INFO - Reading from file tmpfile_stdout 11:34:46 INFO - Current package versions: 11:34:46 INFO - argparse == 1.2.1 11:34:46 INFO - blessings == 1.6 11:34:46 INFO - blobuploader == 1.2.4 11:34:46 INFO - docopt == 0.6.1 11:34:46 INFO - functools32 == 3.2.3-2 11:34:46 INFO - jsonschema == 2.5.1 11:34:46 INFO - manifestparser == 1.1 11:34:46 INFO - mozInstall == 1.13 11:34:46 INFO - mozcrash == 1.0 11:34:46 INFO - mozdebug == 0.1 11:34:46 INFO - mozdevice == 0.51 11:34:46 INFO - mozfile == 1.2 11:34:46 INFO - mozhttpd == 0.7 11:34:46 INFO - mozinfo == 0.10 11:34:46 INFO - mozleak == 0.1 11:34:46 INFO - mozlog == 3.5 11:34:46 INFO - moznetwork == 0.27 11:34:46 INFO - mozprocess == 0.25 11:34:46 INFO - mozprofile == 0.28 11:34:46 INFO - mozrunner == 6.13 11:34:46 INFO - mozscreenshot == 0.1 11:34:46 INFO - mozsystemmonitor == 0.3 11:34:46 INFO - moztest == 0.8 11:34:46 INFO - mozversion == 1.4 11:34:46 INFO - psutil == 3.1.1 11:34:46 INFO - requests == 1.2.3 11:34:46 INFO - wsgiref == 0.1.2 11:34:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:46 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:46 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:34:46 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:34:46 INFO - Using env: {'DISPLAY': ':0', 11:34:46 INFO - 'HOME': '/home/cltbld', 11:34:46 INFO - 'LANG': 'en_US.UTF-8', 11:34:46 INFO - 'LANGUAGE': 'en_US:en', 11:34:46 INFO - 'LOGNAME': 'cltbld', 11:34:46 INFO - 'MAIL': '/var/mail/cltbld', 11:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:46 INFO - 'MOZ_NO_REMOTE': '1', 11:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:46 INFO - 'NO_EM_RESTART': '1', 11:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:46 INFO - 'PWD': '/builds/slave/test', 11:34:46 INFO - 'SHELL': '/bin/bash', 11:34:46 INFO - 'SHLVL': '1', 11:34:46 INFO - 'TERM': 'linux', 11:34:46 INFO - 'TMOUT': '86400', 11:34:46 INFO - 'USER': 'cltbld', 11:34:46 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:46 INFO - '_': '/tools/buildbot/bin/python'} 11:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 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:34:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:34:46 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:34:46 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:34:46 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:34:46 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:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:34:47 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:34:47 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:34:47 INFO - Installing collected packages: simplejson 11:34:47 INFO - Running setup.py install for simplejson 11:34:47 INFO - building 'simplejson._speedups' extension 11:34:47 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:34:48 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:34:48 INFO - Successfully installed simplejson 11:34:48 INFO - Cleaning up... 11:34:48 INFO - Return code: 0 11:34:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:34:48 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 0xa731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc3ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddfa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, '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': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', '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:34:48 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:34:48 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:34:48 INFO - Using env: {'DISPLAY': ':0', 11:34:48 INFO - 'HOME': '/home/cltbld', 11:34:48 INFO - 'LANG': 'en_US.UTF-8', 11:34:48 INFO - 'LANGUAGE': 'en_US:en', 11:34:48 INFO - 'LOGNAME': 'cltbld', 11:34:48 INFO - 'MAIL': '/var/mail/cltbld', 11:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:48 INFO - 'MOZ_NO_REMOTE': '1', 11:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:48 INFO - 'NO_EM_RESTART': '1', 11:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:48 INFO - 'PWD': '/builds/slave/test', 11:34:48 INFO - 'SHELL': '/bin/bash', 11:34:48 INFO - 'SHLVL': '1', 11:34:48 INFO - 'TERM': 'linux', 11:34:48 INFO - 'TMOUT': '86400', 11:34:48 INFO - 'USER': 'cltbld', 11:34:48 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:48 INFO - '_': '/tools/buildbot/bin/python'} 11:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:34:48 INFO - Cleaning up... 11:34:48 INFO - Return code: 0 11:34:48 INFO - Running post-action listener: _resource_record_post_action 11:34:48 INFO - Running post-action listener: _start_resource_monitoring 11:34:48 INFO - Starting resource monitoring. 11:34:48 INFO - [mozharness: 2017-09-01 18:34:48.834693Z] Finished create-virtualenv step (success) 11:34:48 INFO - [mozharness: 2017-09-01 18:34:48.835209Z] Running install step. 11:34:48 INFO - Running pre-action listener: _resource_record_pre_action 11:34:48 INFO - Running main action method: install 11:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:34:49 INFO - Reading from file tmpfile_stdout 11:34:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:34:49 INFO - Reading from file tmpfile_stdout 11:34:49 INFO - Output received: 11:34:49 INFO - Usage: mozinstall [options] installer 11:34:49 INFO - Options: 11:34:49 INFO - -h, --help show this help message and exit 11:34:49 INFO - -d DEST, --destination=DEST 11:34:49 INFO - Directory to install application into. [default: 11:34:49 INFO - "/builds/slave/test"] 11:34:49 INFO - --app=APP Application being installed. [default: firefox] 11:34:49 INFO - mkdir: /builds/slave/test/build/application 11:34:49 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:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:35:05 INFO - Reading from file tmpfile_stdout 11:35:05 INFO - Output received: 11:35:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:35:05 INFO - Running post-action listener: _resource_record_post_action 11:35:05 INFO - [mozharness: 2017-09-01 18:35:05.496135Z] Finished install step (success) 11:35:05 INFO - [mozharness: 2017-09-01 18:35:05.496388Z] Running setup-mitmproxy step. 11:35:05 INFO - Running pre-action listener: _resource_record_pre_action 11:35:05 INFO - Running main action method: setup_mitmproxy 11:35:05 INFO - Skipping: mitmproxy is not required 11:35:05 INFO - Running post-action listener: _resource_record_post_action 11:35:05 INFO - [mozharness: 2017-09-01 18:35:05.497513Z] Finished setup-mitmproxy step (success) 11:35:05 INFO - [mozharness: 2017-09-01 18:35:05.497796Z] Running run-tests step. 11:35:05 INFO - Running pre-action listener: _resource_record_pre_action 11:35:05 INFO - Running pre-action listener: _set_gcov_prefix 11:35:05 INFO - Running main action method: run_tests 11:35:05 WARNING - Try message not found. 11:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:35:05 INFO - Python 2.7.3 11:35:05 INFO - Return code: 0 11:35:05 INFO - grabbing minidump binary from tooltool 11:35: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:35:05 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 0xde3090>, '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 0xde3d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdddf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:35:05 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:35:05 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:35:05 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:35:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:35:05 INFO - Return code: 0 11:35:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:35:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:35:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:35:05 INFO - ENV: RUST_BACKTRACE is now full 11:35:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:35:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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:35:05 INFO - Using env: {'DISPLAY': ':0', 11:35:05 INFO - 'HOME': '/home/cltbld', 11:35:05 INFO - 'LANG': 'en_US.UTF-8', 11:35:05 INFO - 'LANGUAGE': 'en_US:en', 11:35:05 INFO - 'LOGNAME': 'cltbld', 11:35:05 INFO - 'MAIL': '/var/mail/cltbld', 11:35:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:05 INFO - 'MOZ_NO_REMOTE': '1', 11:35:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:05 INFO - 'NO_EM_RESTART': '1', 11:35:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:05 INFO - 'PWD': '/builds/slave/test', 11:35:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:05 INFO - 'RUST_BACKTRACE': 'full', 11:35:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:35:05 INFO - 'SHELL': '/bin/bash', 11:35:05 INFO - 'SHLVL': '1', 11:35:05 INFO - 'TERM': 'linux', 11:35:05 INFO - 'TMOUT': '86400', 11:35:05 INFO - 'USER': 'cltbld', 11:35:05 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:05 INFO - '_': '/tools/buildbot/bin/python'} 11:35:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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:35:05 INFO - mozversion application_buildid: 20170901171938 11:35:05 INFO - mozversion application_changeset: d1292636950a4ac1bb818cf05b113e3fcd6babe1 11:35:05 INFO - mozversion application_display_name: Nightly 11:35:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:35:05 INFO - mozversion application_name: Firefox 11:35:05 INFO - mozversion application_remotingname: firefox 11:35:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:35:05 INFO - mozversion application_vendor: Mozilla 11:35:05 INFO - mozversion application_version: 57.0a1 11:35:05 INFO - mozversion platform_buildid: 20170901171938 11:35:05 INFO - mozversion platform_changeset: d1292636950a4ac1bb818cf05b113e3fcd6babe1 11:35:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:35:05 INFO - mozversion platform_version: 57.0a1 11:35:05 INFO - using testdate: 1504290905 11:35:05 INFO - actual date: 1504290905 11:35:05 INFO - starting webserver on 'localhost:46714' 11:35:05 INFO - SUITE-START | Running 2 tests 11:35:05 INFO - TEST-START | dromaeo_css 11:35:05 INFO - Initialising browser for dromaeo_css test... 11:35:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46714/getInfo.html -profile /tmp/tmpsEp5Zp/profile 11:35:05 INFO - TEST-INFO | started process 4966 (/builds/slave/test/build/application/firefox/firefox http://localhost:46714/getInfo.html) 11:35:11 INFO - TEST-INFO | 4966: exit 0 11:35:11 INFO - Browser initialized. 11:35:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:35:11 INFO - Using env: {'DISPLAY': ':0', 11:35:11 INFO - 'HOME': '/home/cltbld', 11:35:11 INFO - 'JSGC_DISABLE_POISONING': '1', 11:35:11 INFO - 'LANG': 'en_US.UTF-8', 11:35:11 INFO - 'LANGUAGE': 'en_US:en', 11:35:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:35:11 INFO - 'LOGNAME': 'cltbld', 11:35:11 INFO - 'MAIL': '/var/mail/cltbld', 11:35:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:11 INFO - 'MOZ_CRASHREPORTER': '1', 11:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:35:11 INFO - 'MOZ_NO_REMOTE': '1', 11:35:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:11 INFO - 'NO_EM_RESTART': '1', 11:35:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:11 INFO - 'PWD': '/builds/slave/test', 11:35:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:11 INFO - 'RUST_BACKTRACE': 'full', 11:35:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:35:11 INFO - 'SHELL': '/bin/bash', 11:35:11 INFO - 'SHLVL': '1', 11:35:11 INFO - 'TERM': 'linux', 11:35:11 INFO - 'TMOUT': '86400', 11:35:11 INFO - 'USER': 'cltbld', 11:35:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:11 INFO - '_': '/tools/buildbot/bin/python'} 11:35:11 INFO - TEST-INFO | started process 5152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsEp5Zp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:12 INFO - PID 5152 | 11:35:12 INFO - PID 5152 | (/builds/slave/test/build/application/firefox/firefox:5204): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:35:12 INFO - PID 5152 | 11:35:23 INFO - PID 5152 | RSS: Main: 161996800 11:35:23 INFO - PID 5152 | 11:38:22 INFO - PID 5152 | Cycle 1(1): loaded http://localhost:46714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46714/tests/dromaeo/cssquery-ext.html) 11:38:23 INFO - PID 5152 | RSS: Main: 165371904 11:38:23 INFO - PID 5152 | 11:41:24 INFO - PID 5152 | Cycle 1(1): loaded http://localhost:46714/tests/dromaeo/cssquery-ext.html (next: http://localhost:46714/tests/dromaeo/cssquery-jquery.html) 11:41:25 INFO - PID 5152 | RSS: Main: 159408128 11:41:25 INFO - PID 5152 | 11:44:26 INFO - PID 5152 | Cycle 1(1): loaded http://localhost:46714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46714/tests/dromaeo/cssquery-mootools.html) 11:44:27 INFO - PID 5152 | RSS: Main: 163586048 11:44:27 INFO - PID 5152 | 11:47:28 INFO - PID 5152 | Cycle 1(1): loaded http://localhost:46714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46714/tests/dromaeo/cssquery-prototype.html) 11:47:29 INFO - PID 5152 | RSS: Main: 162471936 11:47:29 INFO - PID 5152 | 11:50:32 INFO - PID 5152 | Cycle 1(1): loaded http://localhost:46714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46714/tests/dromaeo/cssquery-yui.html) 11:50:33 INFO - PID 5152 | RSS: Main: 163921920 11:50:33 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | Cycle 1(1): loaded http://localhost:46714/tests/dromaeo/cssquery-yui.html (next: http://localhost:46714/tests/dromaeo/cssquery-dojo.html) 11:53:35 INFO - PID 5152 | RSS: Main: 166236160 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | __start_tp_report 11:53:35 INFO - PID 5152 | _x_x_mozilla_page_load 11:53:35 INFO - PID 5152 | _x_x_mozilla_page_load_details 11:53:35 INFO - PID 5152 | |i|pagename|runs| 11:53:35 INFO - PID 5152 | |0;dojo.html;3869.974456768955;3878.5539662938763;3883.7281390302683;3911.0613452771345;3918.0596656802377;6827.975803629458;6879.552829066113;6905.171379434462;6927.30726927307;6958.095447591819;6848.589084654925;6938.444924406048;6947.235804061549;6949.235584085759;6950.79147625572;6138.785142520024;6144.139820425144;6205.03821907605;6211.9068213976825;6237.0332598447085;6199.504039676837;6220.03589443637;6221.533384996121;6231.127642130105;6264.843378915541;6274.278457977322;6310.716017779188;6332.176817013805;6336.493080553545;6353.428191462767;6149.169862068608;6158;6225.688715564226;6240.4071613196675;6282.748690052415;5907.497862681677;6095.420935011167;6149.754009839601;6156.3843615638525;6171.290301615282;6338.904916426257;6789.25318214996;6824.112865327475;6945.51381403302;6956.965215173892;7367.963160184218;7372;7372.520786148883;7434.962825185894;7487.737929172507;7298.737755932828;7307.415406767446;7446.702131914717;7450.403967682627;7537.849243015109;6833;6887.2079710833395;6887.449004079662;6900.654967251668;6988.44092472601;7653.235339212269;7661.502002369828;7717.151113377524;7780.922190778133;7793.532388056735;7344.045274114331;7367.079115110611;7377.40980721541;7472.738454154187;7474.177840437547;7353.4484913631695;7459.664315105833;7462.888056679154;7491.213422590658;7602.163761986177;7242.855142897112;7255.089629319531;7284.849981479195;7364.3372096511575;7377.88933166003;7299.320774188431;7313.200296669434;7391.704331826774;7393.963030184815;7395.334419902235;6242.719077641517;6257.5932564383165;6318.6524741138755;6350.206224221973;6360.554761166674;5404.783808647689;5411.918821217685;5466.863328416742;5487.451254874561;5607.719614019283;6471.870562588721;6499.480041596661;6506.056621789909;6511.837204069841;6539.051837483634;7425.925740742631;7434.628268586549;7437.739679111205;7547.811304717426;7554.811129721691;6433.099366088752;6450.193725784277;6475.061116138134;6531.1509503765155;6545.410913017851;6635.966820165868;6715.56348837324;6745.224299205556;6802.217744959294;6804.11546498952;7194.568325900463;7217.566945983152;7319.34125928669;7321.267873212742;7323.267673232741;7384.915578209758;7385.372243359375;7398.482106252726;7493.775186744407;7505.136909255505;6984.79045628632;7147;7157.731897423808;7230.891536626849;7306.634668266672;7279.120704469513;7302.525335853153;7402.703891844266;7415.555066696015;7424.257574242532;7408.370288525536;7491.4006879448425;7598.0502437195355;7599.506032107895;7626.923730762622;7172.856542869218;7179.832665414968;7185.784426467214;7298;7313.195548489768;7084.326988936249;7109.608971506616;7168.964155179191;7237.457190710613;7263.709451621876;7088.326608972139;7119.110111236096;7127.287271272831;7134.286571342825;7137.250588688113;7146.785596432115;7238.348548630648;7268.563886166847;7295.890561641473;7315.15875674283;6995.79012629622;7003.019577259086;7013.894791578233;7017.894731579133;7036.120484939383 11:53:35 INFO - PID 5152 | |1;ext.html;939.5912777941596;941.5809964565767;974.9805003899921;997.4962643864848;1005.4017859373674;44651.77674111633;45439.54560454394;45693.77153114238;45697.771511142484;45699;42089.15821683565;42288;42331.36502952458;42410.57589424105;42429.57570424295;7469.253074692528;7568.697252109937;7576.696932122736;7582.393408527305;7602.657880395368;7495.437842161832;7519.924800751977;7521.586312752796;7521.623918804065;7575.772726818204;7451.552906825608;7499.362554182901;7502.437317201205;7543.886841697379;7551.395888328921;7448.776536703907;7465.5893925834325;7474.215207403226;7502.287282708134;7531.359834414081;6861.2795656455855;6928.064711264015;6936.34104760047;6937.7571784987285;6941.68762405693;37826.81086594577;37944.62055379438;37985;38131.42802857959;38184.427233591516;3533.522974398449;3556.5732112146707;3558.430651095838;3560.590532088817;3561.732870034732;29394.265143371587;29419.411611767646;29567.70432295671;29665;29675.554866677016;4487.214737420971;4651.976740116278;4693.366395536593;4698.389209402756;4724.267738500504;202680;203112;204161;208333;212519.99999999846;53443.465565344624;53681;54005.72997135068;54141.729291353295;54197.45802542003;56816.71591642098;57102.428975709714;57142;57166.7141664289;57343;16017.67964640724;16166.676666466605;16173.191340433166;16174.433894813625;16344.673106537803;13303.26832024248;13327.466901324033;13328.200307981551;13334.666633334244;13347.532836350681;14289.356978935974;14332.785008224677;14342.49801256951;14392.496262630757;14484.420623174956;5583.3858275589655;5722.971385143048;5735.913961290584;5823.883522329615;5827.621204621771;1085.7122862441458;1096.0683419093707;1096.5175322857917;1098.3519723363254;1109.1902910875106;25280.87359563227;25541.23376298714;25542.616860747105;25548.616770748453;25790.871045645028;1188.6374655729912;1196.5034510678145;1198.856137263534;1202.482932339085;1206.6802297391023;17180.969141851278;17302.712484627882;17805.376811811526;17967.820321796877;18025.54936126581;264661;265112;265336;265400;266184;61110.69444652748;61170.08244876331;61389;61539.692301538205;61579.69210153921;1442.4405067287614;1446.3925151436422;1476.7784832275245;1482.1107335598554;1487.0780116327946;29555.55666665045;30105;30121.69878301189;30550.541741874335;30794.230144246572;39985.60014399935;40268.59731402648;40311.3953290695;40314.798426007685;40382;228474;228857;231303;234159;237537;34991.30017399689;35587.82206089057;36776;37103;38609.80695096619;48724.512754872;49148.50851491439;49268.2609760861;49314.26028609502;49535.504644953086;35724;36122.819385902905;36218;36291.27417451689;36428.089297767765;35657.46513802347;35672.64327356693;35862.820685896404;35881.82059089688;36542.63457365392;42820.78589607032;42872.57127428811;43031;43124.353134702375;43257.56742432535;34840.12899677528;34884.476732849536;34980.47529287012;35110.82444587761;35496.290074198885;26115.347116322246;26879.731202687723;26923.596146057433;27295.727042730112;27329.86335068312 11:53:35 INFO - PID 5152 | |2;jquery.html;595.2767387624039;608.1425190481422;611.5657882903135;612.1796792298321;631.9747210111594;22952.311430657064;23232.303030909057;24177.879110604466;24279.878600606993;24280.271591852274;23141.30576082716;23456.413589660267;23483.647745283834;23534.88232558839;23594.76405235947;6968.581885086898;7098.467614928875;7101.893471597904;7115.39519140871;7132.786016419515;6264;6846.281140480252;6874.27820078892;6913.032175495435;6999.475039372042;6819.079424277734;6840.486963477759;6841.418479429254;6861.519693621449;6885.070515480396;6800.149981252343;6814.591124532494;6814.591124532519;6862.965685171592;6875.48433867462;6379.681015949184;6392.296847346788;6417.422431981097;6421.51838612106;6424.357564243585;30881.536776948364;31153.844230778926;31193.220169495944;31276.37447251065;31559.211019724462;2238.88805559723;2273.4316420894775;2274.238130226376;2289.0386037864137;2295.690081838947;20855.270065547786;21403.78596214049;21410.678839817414;21445.571088578297;21447.463813404633;2468.456939473313;2518.659980902573;2566.8331558448826;2608.4261462478225;2622.265765585639;155771;159109;160255;163834.1808290963;164430;15609;16016;16664.83335166657;16960.57598560021;17051.147442628066;25450.236492905242;26212;26249.212523624323;26320.73679263221;26363.73636263651;10660.20048496366;10793.892061079288;10820.513076911559;10965.396903170402;11032.779344413068;9840.507974601242;9865.605375785031;9908.405495670282;9979.900200998043;10010.54952527138;10077.364412370245;10109.635199248154;10145.64490242838;10216.6424175155;10250.794984100425;2786.2664030199226;2863.3700585871075;2922.649282086163;2937.7649788016906;2942.6321709786275;1016.7864748402918;1054.984175237372;1064.6646306413454;1084.4415126210008;1085.8425528298353;21816.672749908765;22216.333509994725;22416.887915560645;22571.661425078637;22808.543829123326;1080.2762149359792;1123.0790751583622;1127.937963412004;1135.4379582106744;1142.651491295163;11586.188966772414;12166.330851803059;12176.878231217574;12188;12210.450529726184;634996;638084;648816;649622;657556;141731;142589.28705356407;144820;144911;145149.27425362804;1341.9060665753498;1349.4197495077015;1372.2315503317975;1376.1192836584594;1379.558541266785;19640.901795490932;19670.508237294183;19830.50423739418;19831;19879;58990.41009589849;61826.69086654538;62051;63243;66471.33528664651;81386;81538;81794;84011.15988840278;84436.57781711298;15935.521934341989;16292.429764958644;16456.506304810875;16468.75296870524;16473.258703358137;25452.363690907874;25564.48871022606;25862.482750344512;25903.740962590135;25945.22164335073;19875.701864472332;19986.70019949731;20125.094370753643;20592.27927022547;20772.169113235905;17448.389306374214;17631.735523966894;17743.733843992093;18131.728024079912;18373.265069397075;20845.166193352095;21165.6825147626;21237.7876221242;21526.138954441645;21533.353999380044;15784.763228551352;15880.285387157837;16013.519594412186;16015.95896266739;16047.839521604634;20144.49638759043;20437.182512699324;20569.382918512467;20912.790872091085;20934 11:53:35 INFO - PID 5152 | |3;mootools.html;1434.7345741037907;1483.295434668532;1488.6576087499882;1491.1723993183778;1520.635047588579;16313.265903034362;16993.575160620992;17012;17051.573710657223;17130;17180.656386872255;17486.38797642083;17501.3874514392;17538.29846806126;17560.209790559424;2886.2207204054894;2943.970560294402;2947.4989251827133;2948.39557890633;2953.7341639252463;2837.361593641435;2901.637295338083;2909.519929211688;2910.301527633374;2911.606933064041;2885.3507960708775;2895.102518219348;2904.651441826973;2907.055207057704;2923.5760814681857;2848.2594525423438;2853.2581528802452;2870.669872964594;2878.208492664534;2882.682904880472;2690.8294891721966;2693.9730602693917;2709.0382914065617;2709.1059950216577;2714.4571085782923;16084.195790210442;16482.67034659312;16528.421505247377;16534;16559.6688066238;8579.828403431959;8851.822963540757;8869.73390798277;8876.511791851446;8878.955605221998;5548.722563871831;5780.277465316835;5784.566157538202;5822;5912.231409916726;2095.769465358809;2107.115011695076;2107.4520624637553;2148.967765483519;2154.4613846538364;29538.409231815458;30192.396152076835;30195;30771;31029.534556981664;7438.7024519019715;7440.181580026193;7492;7622.656980435893;7651.426143039294;19709.901450492656;19748.70376944347;19758.50603734918;19780.802191978182;19801;8622.396432249683;8763.430377025474;8767.649294028295;8772.473651580925;8793.164649358301;7864;8026;8077.959610201911;8100.068492123363;8100.635471403801;5684.715764211773;5766.88466230673;5793.15999180125;5910.8817823643285;5921.851953701106;1677.6057626457773;1682.8990260584403;1701.4215166843333;1704.1905095079737;1721.4835549335148;983.8081574092984;1008.0826447932346;1012.473513772834;1017.7862648843677;1030.1810061001522;9744.366616169926;9793.706188814347;9911.157551608194;10000.149987251165;10169.288149829441;1043.3322673488974;1098.1105304703217;1114.966551003455;1121.2767764791827;1127.6504283672089;6213.96893015532;6291.622502649856;6385.744570217233;6440.77457289002;6512.5441219115155;24265.150719724727;24727.38181545476;25411.49177016449;25496.49007019849;25606.615900761502;24836.37909052252;25087.74912250854;25396.746032539806;25443;25465.61801572978;11527.654170374903;11563.07495400366;11637.301761894314;12466.626001219978;12654.114212005072;10240.436775977094;10480.790384192425;10496.212784041074;10598.788024239318;11018.834717479405;20313.085911133738;20407.265382442063;20864.165433382495;20872.895635522334;21555.2455664051;21613.351599452042;21957.23149689817;22055.44861378414;22227.333180004625;22259.443513912283;15318.540443786704;15691.293891774669;15776.290066947244;15785.763213551576;15788.447404340794;15724.371025158865;15724.685506289581;15880;15903.761443578123;15915.204239788196;12632.2420654761;12777.552785652457;12933.676658083623;13077.215367078006;13206.075574709677;12390.132690711564;12479.93760031194;12617.49530018789;12626.053046021401;12879.098463107492;10789.028987391173;10831.566737330419;10849.077828384676;10918.399488028235;10944.890551094388;8578.78553036179;8608.053114157563;8610.65557377698;8683.131686831266;8804.383693141419;8906.376553641183;8974.596143173443;8986;9036.728898133066;9058.63765449401 11:53:35 INFO - PID 5152 | |4;prototype.html;524.7323864828938;562.8705397758514;574.7126436781609;576.6194311754242;579.4958386204003;6781.898271525931;6816.113905192325;6828.760993365233;6917.4466042716585;6928.584284942907;6722.865542689144;6793.35463131003;6797.286284940084;6806.523543351967;6816.898311268374;5466.371367292752;5504.339479262474;5522.392536820947;5527.585431092664;5546.805861794838;4940.716378997225;5223.764930578133;5238.947610523884;5288.4711528847;5453.291072160633;5213.139831927728;5216.921746173811;5250.238715386266;5277.656952298088;5320.658910079572;5199.246109314128;5230;5234.6335756497065;5248.168836749175;5272.182811664198;4671.135839869601;4696.929546056812;4712.128256272601;4752.168370535177;4758.1673207188605;6503.15458990333;6572.338203027782;6574.276829548794;6612.570182938141;6632.403083722488;6108.725107370179;6175.197224360849;6203.7828675996125;6234.87530249397;6287.371262873722;7039.838426659595;7095.751648692322;7114.395276401512;7136.469236341824;7160.964195179043;5262.815801446969;5318.707471089088;5321.068812957756;5326.440723723992;5371.838844834661;7200.711971521133;7278.854422911565;7334.1565719942355;7464.036415783497;7485.026946496921;5421.593380496479;5449.972750136224;5465.890682186334;5494.340679118532;5501.862453438696;5482.916491733115;5518.641288316327;5527.640703354349;5533.501984821385;5580.525655319343;6144.201253837062;6173.69131543421;6225.190725205694;6238.875222495525;6271.874562508724;7077;7131.786046418616;7134.143902731602;7151.427885769126;7207.603581802946;1900.4013735673218;1920.5294702797903;1932.3140285198551;1936.1190658250462;1953.5506833428392;1287.3498883063992;1315.7171208190284;1338.3241463061286;1357.6402253402857;1365.4265208612408;6176.8764624707255;6177.722002509898;6221.782237621662;6262.749490020348;6279.246490421087;7047.260037695968;7120.964395177991;7211.855762884713;7245.239249878687;7277.854442911218;6249.281562520318;6254.499640028786;6271.749130034747;6309.62142271456;6339.873202535923;3815.8473661053804;3822.541295044557;3828;3848.7690738555775;3863.4011728182177;7092.184398794101;7141.14306283239;7142.892856607155;7168.605726684978;7175.390091842148;7398.89476261378;7469.551826890404;7492.962535187289;7542.585157816373;7576.659050342638;7028;7043.168776118144;7115.252898445692;7128.572285662981;7145.606991615407;7224.313690199423;7273.890571734138;7275.1997280298065;7277.59973201479;7340.26597340283;7156.391706704989;7176.354128128493;7243.45674074436;7321.63391830417;7336.96331518339;7018.33325834045;7050.471214659024;7050.682719277747;7076.646167691698;7112.608806515691;5470.64440811346;5475.370332411664;5479.3972663007835;5496.31296087989;5499.3675727291875;7024.438044956289;7049.894251586128;7276.636168191675;7361.521501102411;7379.281057180728;6959.338862808025;7000.369966703021;7037;7068.717251310096;7089.574625522485;7019.2629773873;7025.156981162088;7041.647917604202;7042.718291268292;7064.611446370499;6895.6552172390175;6999.160100787938;7033.366996970297;7037.964810175917;7039.436845052486;6983.1620205575655;7043.36609705129;7123.786286411416;7132.607706576188;7174.964125179341;6779.186497620317;6799.5920244785475;6804.693788779616;6935.549189302679;6944.722211111499 11:53:35 INFO - PID 5152 | |5;yui.html;959.3092973059395;963.8168747937892;992.8312186928222;998.2912132386006;1007.6422869881189;20159.798402015975;20399.99999999998;20454.795452045477;20552.89723551382;23000.769992300073;21367.14531418745;21853.781462185372;21867.343979680594;21871.234506792265;21916.561668766655;1065.2170654568886;1088.1784252889097;1093.3439936038392;1094.1301665176163;1094.409019129671;1046.8272734998716;1069.5507886687571;1086.3047649504324;1090.8909109089068;1095.0418383914075;1130.1693255457233;1132.3092913322866;1133.9036181924546;1135.0862555642705;1135.3074624479102;1135.2167004766768;1135.3131355529868;1135.5855112883737;1136.1138312116561;1140.9600663976762;833.6998680475024;833.8999320081629;833.954132522711;834.5368320582074;837.3217693668088;19918.90040549788;20185.091670874845;20644;20946.790532094637;21208.787912120835;21946.231881884058;22030.88984555083;22195.889020554954;22197.335199859914;22641.660375094387;18315.816841831544;18504;18768.71846922297;18812.34156804519;18922.3377181798;3949.565547789741;3967.0677390813134;3971.801409929521;3974.602539746002;3974.841006359742;155594;157227;157847.21076394658;158056;158154;16812.24344904482;17617.207225674876;17761.378351757627;17996.55008624795;18191.727124092886;33577.16057098592;33757.66242337594;33798.15504612404;34414.82792586021;34428;8549.829003420022;8838.911610883808;9095.636174553076;9403.529823508798;9710.17463515609;4625.95374046262;4712.081144176853;4717.127331443694;4717.787699553528;4735.052989402134;5724.427557244326;5802.071668533014;5820.388859169726;5822.970885145632;5878.235829342244;1186.2170967161805;1202.8616709078392;1220.2434490615874;1223.0582451512287;1225.8161275808523;734.7612026091541;756.7086671631462;758.2417582417582;761.9123800762873;773.4663082473076;12986.935065324613;13684.52104176349;14082.647933801532;14347.713045739027;14406.42374305037;747.1445195251515;764.6100488750666;764.8355603545265;774.5933384972934;780.6292011294703;6367.7452901884335;6370.58591191571;6414.230292364946;6459.418652321314;6515.185601799775;128393.35803320924;128946;129763.35118324347;131038;137320;112491;114066.50890521858;114426;116423.08942276341;118809;96550;98409;98836;100070;100720.49639751755;12045;12093.455794489093;12095.39523023863;12152.878471215176;12458;48799.5120048795;49258.75370623124;49643.50356496389;50346.2448063272;50554.49445505498;64379.67810160919;64548;65113.674431629435;65291;65316.67341663261;16287.755683664991;16361.918190408971;16677.416290429777;16752.246148923085;18822.52943676419;23014.309570712907;23131.88434057886;23151.421214469774;23286.417839554146;23382.064717411115;19322;19569.315073972342;19603.509912252306;19614.901925490853;19826.504337391103;19105.33131340452;19221.615567688288;19258.90370548138;19315.323963661205;19359.3224237151;18922.621547568695;19048.04759762034;19116.71324930155;19176.712349314494;19282.421527354203;13877.167369957835;14296;14332.211728355041;15083.849161508684;15134.545963620669;15488.434123705603;15903.891303262179;16059.19704014818;16166.353345866033;16193.75709364337 11:53:35 INFO - PID 5152 | __end_tp_report 11:53:35 INFO - PID 5152 | __start_cc_report 11:53:35 INFO - PID 5152 | _x_x_mozilla_cycle_collect,332 11:53:35 INFO - PID 5152 | __end_cc_report 11:53:35 INFO - PID 5152 | __startTimestamp1504292015261__endTimestamp 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | ------- Summary: start ------- 11:53:35 INFO - PID 5152 | Number of tests: 6 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | [#0] dojo.html Cycles:165 Average:6851.00 Median:7088.33 stddev:746.47 (10.5%) stddev-sans-first:711.19 11:53:35 INFO - PID 5152 | Values: 3870.0 3878.6 3883.7 3911.1 3918.1 6828.0 6879.6 6905.2 6927.3 6958.1 6848.6 6938.4 6947.2 6949.2 6950.8 6138.8 6144.1 6205.0 6211.9 6237.0 6199.5 6220.0 6221.5 6231.1 6264.8 6274.3 6310.7 6332.2 6336.5 6353.4 6149.2 6158.0 6225.7 6240.4 6282.7 5907.5 6095.4 6149.8 6156.4 6171.3 6338.9 6789.3 6824.1 6945.5 6957.0 7368.0 7372.0 7372.5 7435.0 7487.7 7298.7 7307.4 7446.7 7450.4 7537.8 6833.0 6887.2 6887.4 6900.7 6988.4 7653.2 7661.5 7717.2 7780.9 7793.5 7344.0 7367.1 7377.4 7472.7 7474.2 7353.4 7459.7 7462.9 7491.2 7602.2 7242.9 7255.1 7284.8 7364.3 7377.9 7299.3 7313.2 7391.7 7394.0 7395.3 6242.7 6257.6 6318.7 6350.2 6360.6 5404.8 5411.9 5466.9 5487.5 5607.7 6471.9 6499.5 6506.1 6511.8 6539.1 7425.9 7434.6 7437.7 7547.8 7554.8 6433.1 6450.2 6475.1 6531.2 6545.4 6636.0 6715.6 6745.2 6802.2 6804.1 7194.6 7217.6 7319.3 7321.3 7323.3 7384.9 7385.4 7398.5 7493.8 7505.1 6984.8 7147.0 7157.7 7230.9 7306.6 7279.1 7302.5 7402.7 7415.6 7424.3 7408.4 7491.4 7598.1 7599.5 7626.9 7172.9 7179.8 7185.8 7298.0 7313.2 7084.3 7109.6 7169.0 7237.5 7263.7 7088.3 7119.1 7127.3 7134.3 7137.3 7146.8 7238.3 7268.6 7295.9 7315.2 6995.8 7003.0 7013.9 7017.9 7036.1 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | [#1] ext.html Cycles:180 Average:41870.80 Median:36359.68 stddev:61279.26 (168.5%) stddev-sans-first:61374.09 11:53:35 INFO - PID 5152 | Values: 939.6 941.6 975.0 997.5 1005.4 44651.8 45439.5 45693.8 45697.8 45699.0 42089.2 42288.0 42331.4 42410.6 42429.6 7469.3 7568.7 7576.7 7582.4 7602.7 7495.4 7519.9 7521.6 7521.6 7575.8 7451.6 7499.4 7502.4 7543.9 7551.4 7448.8 7465.6 7474.2 7502.3 7531.4 6861.3 6928.1 6936.3 6937.8 6941.7 37826.8 37944.6 37985.0 38131.4 38184.4 3533.5 3556.6 3558.4 3560.6 3561.7 29394.3 29419.4 29567.7 29665.0 29675.6 4487.2 4652.0 4693.4 4698.4 4724.3 202680.0 203112.0 204161.0 208333.0 212520.0 53443.5 53681.0 54005.7 54141.7 54197.5 56816.7 57102.4 57142.0 57166.7 57343.0 16017.7 16166.7 16173.2 16174.4 16344.7 13303.3 13327.5 13328.2 13334.7 13347.5 14289.4 14332.8 14342.5 14392.5 14484.4 5583.4 5723.0 5735.9 5823.9 5827.6 1085.7 1096.1 1096.5 1098.4 1109.2 25280.9 25541.2 25542.6 25548.6 25790.9 1188.6 1196.5 1198.9 1202.5 1206.7 17181.0 17302.7 17805.4 17967.8 18025.5 264661.0 265112.0 265336.0 265400.0 266184.0 61110.7 61170.1 61389.0 61539.7 61579.7 1442.4 1446.4 1476.8 1482.1 1487.1 29555.6 30105.0 30121.7 30550.5 30794.2 39985.6 40268.6 40311.4 40314.8 40382.0 228474.0 228857.0 231303.0 234159.0 237537.0 34991.3 35587.8 36776.0 37103.0 38609.8 48724.5 49148.5 49268.3 49314.3 49535.5 35724.0 36122.8 36218.0 36291.3 36428.1 35657.5 35672.6 35862.8 35881.8 36542.6 42820.8 42872.6 43031.0 43124.4 43257.6 34840.1 34884.5 34980.5 35110.8 35496.3 26115.3 26879.7 26923.6 27295.7 27329.9 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | [#2] jquery.html Cycles:180 Average:41855.66 Median:12422.55 stddev:108215.68 (871.1%) stddev-sans-first:108474.91 11:53:35 INFO - PID 5152 | Values: 595.3 608.1 611.6 612.2 632.0 22952.3 23232.3 24177.9 24279.9 24280.3 23141.3 23456.4 23483.6 23534.9 23594.8 6968.6 7098.5 7101.9 7115.4 7132.8 6264.0 6846.3 6874.3 6913.0 6999.5 6819.1 6840.5 6841.4 6861.5 6885.1 6800.1 6814.6 6814.6 6863.0 6875.5 6379.7 6392.3 6417.4 6421.5 6424.4 30881.5 31153.8 31193.2 31276.4 31559.2 2238.9 2273.4 2274.2 2289.0 2295.7 20855.3 21403.8 21410.7 21445.6 21447.5 2468.5 2518.7 2566.8 2608.4 2622.3 155771.0 159109.0 160255.0 163834.2 164430.0 15609.0 16016.0 16664.8 16960.6 17051.1 25450.2 26212.0 26249.2 26320.7 26363.7 10660.2 10793.9 10820.5 10965.4 11032.8 9840.5 9865.6 9908.4 9979.9 10010.5 10077.4 10109.6 10145.6 10216.6 10250.8 2786.3 2863.4 2922.6 2937.8 2942.6 1016.8 1055.0 1064.7 1084.4 1085.8 21816.7 22216.3 22416.9 22571.7 22808.5 1080.3 1123.1 1127.9 1135.4 1142.7 11586.2 12166.3 12176.9 12188.0 12210.5 634996.0 638084.0 648816.0 649622.0 657556.0 141731.0 142589.3 144820.0 144911.0 145149.3 1341.9 1349.4 1372.2 1376.1 1379.6 19640.9 19670.5 19830.5 19831.0 19879.0 58990.4 61826.7 62051.0 63243.0 66471.3 81386.0 81538.0 81794.0 84011.2 84436.6 15935.5 16292.4 16456.5 16468.8 16473.3 25452.4 25564.5 25862.5 25903.7 25945.2 19875.7 19986.7 20125.1 20592.3 20772.2 17448.4 17631.7 17743.7 18131.7 18373.3 20845.2 21165.7 21237.8 21526.1 21533.4 15784.8 15880.3 16013.5 16016.0 16047.8 20144.5 20437.2 20569.4 20912.8 20934.0 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | [#3] mootools.html Cycles:180 Average:10690.60 Median:23262.30 stddev:7711.73 (33.2%) stddev-sans-first:7702.00 11:53:35 INFO - PID 5152 | Values: 1434.7 1483.3 1488.7 1491.2 1520.6 16313.3 16993.6 17012.0 17051.6 17130.0 17180.7 17486.4 17501.4 17538.3 17560.2 2886.2 2944.0 2947.5 2948.4 2953.7 2837.4 2901.6 2909.5 2910.3 2911.6 2885.4 2895.1 2904.7 2907.1 2923.6 2848.3 2853.3 2870.7 2878.2 2882.7 2690.8 2694.0 2709.0 2709.1 2714.5 16084.2 16482.7 16528.4 16534.0 16559.7 8579.8 8851.8 8869.7 8876.5 8879.0 5548.7 5780.3 5784.6 5822.0 5912.2 2095.8 2107.1 2107.5 2149.0 2154.5 29538.4 30192.4 30195.0 30771.0 31029.5 7438.7 7440.2 7492.0 7622.7 7651.4 19709.9 19748.7 19758.5 19780.8 19801.0 8622.4 8763.4 8767.6 8772.5 8793.2 7864.0 8026.0 8078.0 8100.1 8100.6 5684.7 5766.9 5793.2 5910.9 5921.9 1677.6 1682.9 1701.4 1704.2 1721.5 983.8 1008.1 1012.5 1017.8 1030.2 9744.4 9793.7 9911.2 10000.1 10169.3 1043.3 1098.1 1115.0 1121.3 1127.7 6214.0 6291.6 6385.7 6440.8 6512.5 24265.2 24727.4 25411.5 25496.5 25606.6 24836.4 25087.7 25396.7 25443.0 25465.6 11527.7 11563.1 11637.3 12466.6 12654.1 10240.4 10480.8 10496.2 10598.8 11018.8 20313.1 20407.3 20864.2 20872.9 21555.2 21613.4 21957.2 22055.4 22227.3 22259.4 15318.5 15691.3 15776.3 15785.8 15788.4 15724.4 15724.7 15880.0 15903.8 15915.2 12632.2 12777.6 12933.7 13077.2 13206.1 12390.1 12479.9 12617.5 12626.1 12879.1 10789.0 10831.6 10849.1 10918.4 10944.9 8578.8 8608.1 8610.7 8683.1 8804.4 8906.4 8974.6 8986.0 9036.7 9058.6 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | [#4] prototype.html Cycles:180 Average:5969.22 Median:6751.03 stddev:1677.94 (24.9%) stddev-sans-first:1632.13 11:53:35 INFO - PID 5152 | Values: 524.7 562.9 574.7 576.6 579.5 6781.9 6816.1 6828.8 6917.4 6928.6 6722.9 6793.4 6797.3 6806.5 6816.9 5466.4 5504.3 5522.4 5527.6 5546.8 4940.7 5223.8 5238.9 5288.5 5453.3 5213.1 5216.9 5250.2 5277.7 5320.7 5199.2 5230.0 5234.6 5248.2 5272.2 4671.1 4696.9 4712.1 4752.2 4758.2 6503.2 6572.3 6574.3 6612.6 6632.4 6108.7 6175.2 6203.8 6234.9 6287.4 7039.8 7095.8 7114.4 7136.5 7161.0 5262.8 5318.7 5321.1 5326.4 5371.8 7200.7 7278.9 7334.2 7464.0 7485.0 5421.6 5450.0 5465.9 5494.3 5501.9 5482.9 5518.6 5527.6 5533.5 5580.5 6144.2 6173.7 6225.2 6238.9 6271.9 7077.0 7131.8 7134.1 7151.4 7207.6 1900.4 1920.5 1932.3 1936.1 1953.6 1287.3 1315.7 1338.3 1357.6 1365.4 6176.9 6177.7 6221.8 6262.7 6279.2 7047.3 7121.0 7211.9 7245.2 7277.9 6249.3 6254.5 6271.7 6309.6 6339.9 3815.8 3822.5 3828.0 3848.8 3863.4 7092.2 7141.1 7142.9 7168.6 7175.4 7398.9 7469.6 7493.0 7542.6 7576.7 7028.0 7043.2 7115.3 7128.6 7145.6 7224.3 7273.9 7275.2 7277.6 7340.3 7156.4 7176.4 7243.5 7321.6 7337.0 7018.3 7050.5 7050.7 7076.6 7112.6 5470.6 5475.4 5479.4 5496.3 5499.4 7024.4 7049.9 7276.6 7361.5 7379.3 6959.3 7000.4 7037.0 7068.7 7089.6 7019.3 7025.2 7041.6 7042.7 7064.6 6895.7 6999.2 7033.4 7038.0 7039.4 6983.2 7043.4 7123.8 7132.6 7175.0 6779.2 6799.6 6804.7 6935.5 6944.7 11:53:35 INFO - PID 5152 | 11:53:35 INFO - PID 5152 | [#5] yui.html Cycles:180 Average:26855.51 Median:19609.21 stddev:38246.30 (195.0%) stddev-sans-first:38304.16 11:53:35 INFO - PID 5152 | Values: 959.3 963.8 992.8 998.3 1007.6 20159.8 20400.0 20454.8 20552.9 23000.8 21367.1 21853.8 21867.3 21871.2 21916.6 1065.2 1088.2 1093.3 1094.1 1094.4 1046.8 1069.6 1086.3 1090.9 1095.0 1130.2 1132.3 1133.9 1135.1 1135.3 1135.2 1135.3 1135.6 1136.1 1141.0 833.7 833.9 834.0 834.5 837.3 19918.9 20185.1 20644.0 20946.8 21208.8 21946.2 22030.9 22195.9 22197.3 22641.7 18315.8 18504.0 18768.7 18812.3 18922.3 3949.6 3967.1 3971.8 3974.6 3974.8 155594.0 157227.0 157847.2 158056.0 158154.0 16812.2 17617.2 17761.4 17996.6 18191.7 33577.2 33757.7 33798.2 34414.8 34428.0 8549.8 8838.9 9095.6 9403.5 9710.2 4626.0 4712.1 4717.1 4717.8 4735.1 5724.4 5802.1 5820.4 5823.0 5878.2 1186.2 1202.9 1220.2 1223.1 1225.8 734.8 756.7 758.2 761.9 773.5 12986.9 13684.5 14082.6 14347.7 14406.4 747.1 764.6 764.8 774.6 780.6 6367.7 6370.6 6414.2 6459.4 6515.2 128393.4 128946.0 129763.4 131038.0 137320.0 112491.0 114066.5 114426.0 116423.1 118809.0 96550.0 98409.0 98836.0 100070.0 100720.5 12045.0 12093.5 12095.4 12152.9 12458.0 48799.5 49258.8 49643.5 50346.2 50554.5 64379.7 64548.0 65113.7 65291.0 65316.7 16287.8 16361.9 16677.4 16752.2 18822.5 23014.3 23131.9 23151.4 23286.4 23382.1 19322.0 19569.3 19603.5 19614.9 19826.5 19105.3 19221.6 19258.9 19315.3 19359.3 18922.6 19048.0 19116.7 19176.7 19282.4 13877.2 14296.0 14332.2 15083.8 15134.5 15488.4 15903.9 16059.2 16166.4 16193.8 11:53:35 INFO - PID 5152 | -------- Summary: end -------- 11:53:35 INFO - PID 5152 | 11:53:36 INFO - TEST-INFO | 5152: exit 0 11:53:36 INFO - TEST-OK | dromaeo_css | took 1110206ms 11:53:36 INFO - TEST-START | kraken 11:53:36 INFO - Initialising browser for kraken test... 11:53:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46714/getInfo.html -profile /tmp/tmp8R5bWd/profile 11:53:36 INFO - TEST-INFO | started process 5527 (/builds/slave/test/build/application/firefox/firefox http://localhost:46714/getInfo.html) 11:53:41 INFO - TEST-INFO | 5527: exit 0 11:53:41 INFO - Browser initialized. 11:53:41 INFO - Running cycle 1/1 for kraken test... 11:53:41 INFO - Using env: {'DISPLAY': ':0', 11:53:41 INFO - 'HOME': '/home/cltbld', 11:53:41 INFO - 'JSGC_DISABLE_POISONING': '1', 11:53:41 INFO - 'LANG': 'en_US.UTF-8', 11:53:41 INFO - 'LANGUAGE': 'en_US:en', 11:53:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:53:41 INFO - 'LOGNAME': 'cltbld', 11:53:41 INFO - 'MAIL': '/var/mail/cltbld', 11:53:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:53:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:53:41 INFO - 'MOZ_CRASHREPORTER': '1', 11:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:53:41 INFO - 'MOZ_NO_REMOTE': '1', 11:53:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:41 INFO - 'NO_EM_RESTART': '1', 11:53:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:41 INFO - 'PWD': '/builds/slave/test', 11:53:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:53:41 INFO - 'RUST_BACKTRACE': 'full', 11:53:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:53:41 INFO - 'SHELL': '/bin/bash', 11:53:41 INFO - 'SHLVL': '1', 11:53:41 INFO - 'TERM': 'linux', 11:53:41 INFO - 'TMOUT': '86400', 11:53:41 INFO - 'USER': 'cltbld', 11:53:41 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874', 11:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:41 INFO - '_': '/tools/buildbot/bin/python'} 11:53:41 INFO - TEST-INFO | started process 5715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8R5bWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:42 INFO - PID 5715 | 11:53:42 INFO - PID 5715 | (/builds/slave/test/build/application/firefox/firefox:5768): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:53:42 INFO - PID 5715 | 11:53:52 INFO - PID 5715 | RSS: Main: 161873920 11:53:52 INFO - PID 5715 | 11:53:55 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46714/tests/kraken/driver.html?testName=audio-beat-detection) 11:53:56 INFO - PID 5715 | RSS: Main: 166641664 11:53:56 INFO - PID 5715 | 11:53:58 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46714/tests/kraken/driver.html?testName=audio-dft) 11:53:59 INFO - PID 5715 | RSS: Main: 170618880 11:53:59 INFO - PID 5715 | 11:54:02 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46714/tests/kraken/driver.html?testName=audio-fft) 11:54:03 INFO - PID 5715 | RSS: Main: 163622912 11:54:03 INFO - PID 5715 | 11:54:05 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46714/tests/kraken/driver.html?testName=audio-oscillator) 11:54:05 INFO - PID 5715 | RSS: Main: 164229120 11:54:05 INFO - PID 5715 | 11:54:07 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:54:08 INFO - PID 5715 | RSS: Main: 164470784 11:54:08 INFO - PID 5715 | 11:54:11 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46714/tests/kraken/driver.html?testName=imaging-darkroom) 11:54:12 INFO - PID 5715 | RSS: Main: 165081088 11:54:12 INFO - PID 5715 | 11:54:15 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46714/tests/kraken/driver.html?testName=imaging-desaturate) 11:54:16 INFO - PID 5715 | RSS: Main: 166121472 11:54:16 INFO - PID 5715 | 11:54:18 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46714/tests/kraken/driver.html?testName=json-parse-financial) 11:54:19 INFO - PID 5715 | RSS: Main: 166445056 11:54:19 INFO - PID 5715 | 11:54:20 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:54:21 INFO - PID 5715 | RSS: Main: 166297600 11:54:21 INFO - PID 5715 | 11:54:23 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:54:23 INFO - PID 5715 | RSS: Main: 166318080 11:54:23 INFO - PID 5715 | 11:54:25 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:54:26 INFO - PID 5715 | RSS: Main: 163475456 11:54:26 INFO - PID 5715 | 11:54:28 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:54:29 INFO - PID 5715 | RSS: Main: 163250176 11:54:29 INFO - PID 5715 | 11:54:32 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:54:32 INFO - PID 5715 | RSS: Main: 163549184 11:54:32 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | Cycle 1(1): loaded http://localhost:46714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46714/tests/kraken/driver.html?testName=ai-astar) 11:54:34 INFO - PID 5715 | RSS: Main: 165539840 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | __start_tp_report 11:54:34 INFO - PID 5715 | _x_x_mozilla_page_load 11:54:34 INFO - PID 5715 | _x_x_mozilla_page_load_details 11:54:34 INFO - PID 5715 | |i|pagename|runs| 11:54:34 INFO - PID 5715 | |0;ai-astar;95;106;98;106;104;105;107;98;105;108 11:54:34 INFO - PID 5715 | |1;audio-beat-detection;144;111;154;181;112;140;148;114;165;117 11:54:34 INFO - PID 5715 | |2;audio-dft;164;163;164;161;162;162;162;160;167;165 11:54:34 INFO - PID 5715 | |3;audio-fft;72;73;73;173;73;72;72;88;97;73 11:54:34 INFO - PID 5715 | |4;audio-oscillator;79;78;126;79;77;78;123;81;78;126 11:54:34 INFO - PID 5715 | |5;imaging-gaussian-blur;114;113;115;114;114;114;113;113;114;113 11:54:34 INFO - PID 5715 | |6;imaging-darkroom;150;149;149;150;149;149;151;151;150;149 11:54:34 INFO - PID 5715 | |7;imaging-desaturate;94;97;94;94;94;93;94;93;93;94 11:54:34 INFO - PID 5715 | |8;json-parse-financial;46;45;48;43;43;43;43;43;43;45 11:54:34 INFO - PID 5715 | |9;json-stringify-tinderbox;36;37;36;36;36;36;36;36;36;36 11:54:34 INFO - PID 5715 | |10;stanford-crypto-aes;73;73;73;73;74;73;71;75;72;72 11:54:34 INFO - PID 5715 | |11;stanford-crypto-ccm;111;120;114;110;110;109;115;126;114;155 11:54:34 INFO - PID 5715 | |12;stanford-crypto-pbkdf2;167;165;154;164;166;156;157;153;156;153 11:54:34 INFO - PID 5715 | |13;stanford-crypto-sha256-iterative;60;58;60;66;61;60;59;60;62;57 11:54:34 INFO - PID 5715 | __end_tp_report 11:54:34 INFO - PID 5715 | __start_cc_report 11:54:34 INFO - PID 5715 | _x_x_mozilla_cycle_collect,908 11:54:34 INFO - PID 5715 | __end_cc_report 11:54:34 INFO - PID 5715 | __startTimestamp1504292074896__endTimestamp 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | ------- Summary: start ------- 11:54:34 INFO - PID 5715 | Number of tests: 14 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#0] ai-astar Cycles:10 Average:103.20 Median:107.50 stddev:4.49 (4.2%) stddev-sans-first:3.66 11:54:34 INFO - PID 5715 | Values: 95.0 106.0 98.0 106.0 104.0 105.0 107.0 98.0 105.0 108.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:146.00 stddev:24.48 (16.8%) stddev-sans-first:25.88 11:54:34 INFO - PID 5715 | Values: 144.0 111.0 154.0 181.0 112.0 140.0 148.0 114.0 165.0 117.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:2.05 (1.3%) stddev-sans-first:2.15 11:54:34 INFO - PID 5715 | Values: 164.0 163.0 164.0 161.0 162.0 162.0 162.0 160.0 167.0 165.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#3] audio-fft Cycles:10 Average:86.60 Median:73.00 stddev:31.54 (43.2%) stddev-sans-first:33.01 11:54:34 INFO - PID 5715 | Values: 72.0 73.0 73.0 173.0 73.0 72.0 72.0 88.0 97.0 73.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:78.00 stddev:22.47 (28.8%) stddev-sans-first:23.29 11:54:34 INFO - PID 5715 | Values: 79.0 78.0 126.0 79.0 77.0 78.0 123.0 81.0 78.0 126.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:54:34 INFO - PID 5715 | Values: 114.0 113.0 115.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 11:54:34 INFO - PID 5715 | Values: 150.0 149.0 149.0 150.0 149.0 149.0 151.0 151.0 150.0 149.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:1.15 (1.2%) stddev-sans-first:1.22 11:54:34 INFO - PID 5715 | Values: 94.0 97.0 94.0 94.0 94.0 93.0 94.0 93.0 93.0 94.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:44.00 stddev:1.75 (4.0%) stddev-sans-first:1.73 11:54:34 INFO - PID 5715 | Values: 46.0 45.0 48.0 43.0 43.0 43.0 43.0 43.0 43.0 45.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#9] json-stringify-tinderbox Cycles:10 Average:36.10 Median:36.00 stddev:0.32 (0.9%) stddev-sans-first:0.33 11:54:34 INFO - PID 5715 | Values: 36.0 37.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 36.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 11:54:34 INFO - PID 5715 | Values: 73.0 73.0 73.0 73.0 74.0 73.0 71.0 75.0 72.0 72.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:114.50 stddev:13.88 (12.1%) stddev-sans-first:14.46 11:54:34 INFO - PID 5715 | Values: 111.0 120.0 114.0 110.0 110.0 109.0 115.0 126.0 114.0 155.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.50 stddev:5.70 (3.6%) stddev-sans-first:5.29 11:54:34 INFO - PID 5715 | Values: 167.0 165.0 154.0 164.0 166.0 156.0 157.0 153.0 156.0 153.0 11:54:34 INFO - PID 5715 | 11:54:34 INFO - PID 5715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.00 stddev:2.45 (4.1%) stddev-sans-first:2.60 11:54:34 INFO - PID 5715 | Values: 60.0 58.0 60.0 66.0 61.0 60.0 59.0 60.0 62.0 57.0 11:54:34 INFO - PID 5715 | -------- Summary: end -------- 11:54:34 INFO - PID 5715 | 11:54:35 INFO - PID 5715 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:54:35 INFO - TEST-INFO | 5715: exit 0 11:54:35 INFO - TEST-OK | kraken | took 59804ms 11:54:35 INFO - SUITE-END | took 1170s 11:54:36 INFO - Completed test suite (00:19:30) 11:54:36 INFO - javascript benchmark 11:54:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9381.27545107589, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3869.974456768955, 3878.5539662938763, 3883.7281390302683, 3911.0613452771345, 3918.0596656802377, 6827.975803629458, 6879.552829066113, 6905.171379434462, 6927.30726927307, 6958.095447591819, 6848.589084654925, 6938.444924406048, 6947.235804061549, 6949.235584085759, 6950.79147625572, 6138.785142520024, 6144.139820425144, 6205.03821907605, 6211.9068213976825, 6237.0332598447085, 6199.504039676837, 6220.03589443637, 6221.533384996121, 6231.127642130105, 6264.843378915541, 6274.278457977322, 6310.716017779188, 6332.176817013805, 6336.493080553545, 6353.428191462767, 6149.169862068608, 6158.0, 6225.688715564226, 6240.4071613196675, 6282.748690052415, 5907.497862681677, 6095.420935011167, 6149.754009839601, 6156.3843615638525, 6171.290301615282, 6338.904916426257, 6789.25318214996, 6824.112865327475, 6945.51381403302, 6956.965215173892, 7367.963160184218, 7372.0, 7372.520786148883, 7434.962825185894, 7487.737929172507, 7298.737755932828, 7307.415406767446, 7446.702131914717, 7450.403967682627, 7537.849243015109, 6833.0, 6887.2079710833395, 6887.449004079662, 6900.654967251668, 6988.44092472601, 7653.235339212269, 7661.502002369828, 7717.151113377524, 7780.922190778133, 7793.532388056735, 7344.045274114331, 7367.079115110611, 7377.40980721541, 7472.738454154187, 7474.177840437547, 7353.4484913631695, 7459.664315105833, 7462.888056679154, 7491.213422590658, 7602.163761986177, 7242.855142897112, 7255.089629319531, 7284.849981479195, 7364.3372096511575, 7377.88933166003, 7299.320774188431, 7313.200296669434, 7391.704331826774, 7393.963030184815, 7395.334419902235, 6242.719077641517, 6257.5932564383165, 6318.6524741138755, 6350.206224221973, 6360.554761166674, 5404.783808647689, 5411.918821217685, 5466.863328416742, 5487.451254874561, 5607.719614019283, 6471.870562588721, 6499.480041596661, 6506.056621789909, 6511.837204069841, 6539.051837483634, 7425.925740742631, 7434.628268586549, 7437.739679111205, 7547.811304717426, 7554.811129721691, 6433.099366088752, 6450.193725784277, 6475.061116138134, 6531.1509503765155, 6545.410913017851, 6635.966820165868, 6715.56348837324, 6745.224299205556, 6802.217744959294, 6804.11546498952, 7194.568325900463, 7217.566945983152, 7319.34125928669, 7321.267873212742, 7323.267673232741, 7384.915578209758, 7385.372243359375, 7398.482106252726, 7493.775186744407, 7505.136909255505, 6984.79045628632, 7147.0, 7157.731897423808, 7230.891536626849, 7306.634668266672, 7279.120704469513, 7302.525335853153, 7402.703891844266, 7415.555066696015, 7424.257574242532, 7408.370288525536, 7491.4006879448425, 7598.0502437195355, 7599.506032107895, 7626.923730762622, 7172.856542869218, 7179.832665414968, 7185.784426467214, 7298.0, 7313.195548489768, 7084.326988936249, 7109.608971506616, 7168.964155179191, 7237.457190710613, 7263.709451621876, 7088.326608972139, 7119.110111236096, 7127.287271272831, 7134.286571342825, 7137.250588688113, 7146.785596432115, 7238.348548630648, 7268.563886166847, 7295.890561641473, 7315.15875674283, 6995.79012629622, 7003.019577259086, 7013.894791578233, 7017.894731579133, 7036.120484939383], "value": 6802.287034682722, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [939.5912777941596, 941.5809964565767, 974.9805003899921, 997.4962643864848, 1005.4017859373674, 44651.77674111633, 45439.54560454394, 45693.77153114238, 45697.771511142484, 45699.0, 42089.15821683565, 42288.0, 42331.36502952458, 42410.57589424105, 42429.57570424295, 7469.253074692528, 7568.697252109937, 7576.696932122736, 7582.393408527305, 7602.657880395368, 7495.437842161832, 7519.924800751977, 7521.586312752796, 7521.623918804065, 7575.772726818204, 7451.552906825608, 7499.362554182901, 7502.437317201205, 7543.886841697379, 7551.395888328921, 7448.776536703907, 7465.5893925834325, 7474.215207403226, 7502.287282708134, 7531.359834414081, 6861.2795656455855, 6928.064711264015, 6936.34104760047, 6937.7571784987285, 6941.68762405693, 37826.81086594577, 37944.62055379438, 37985.0, 38131.42802857959, 38184.427233591516, 3533.522974398449, 3556.5732112146707, 3558.430651095838, 3560.590532088817, 3561.732870034732, 29394.265143371587, 29419.411611767646, 29567.70432295671, 29665.0, 29675.554866677016, 4487.214737420971, 4651.976740116278, 4693.366395536593, 4698.389209402756, 4724.267738500504, 202680.0, 203112.0, 204161.0, 208333.0, 212519.99999999846, 53443.465565344624, 53681.0, 54005.72997135068, 54141.729291353295, 54197.45802542003, 56816.71591642098, 57102.428975709714, 57142.0, 57166.7141664289, 57343.0, 16017.67964640724, 16166.676666466605, 16173.191340433166, 16174.433894813625, 16344.673106537803, 13303.26832024248, 13327.466901324033, 13328.200307981551, 13334.666633334244, 13347.532836350681, 14289.356978935974, 14332.785008224677, 14342.49801256951, 14392.496262630757, 14484.420623174956, 5583.3858275589655, 5722.971385143048, 5735.913961290584, 5823.883522329615, 5827.621204621771, 1085.7122862441458, 1096.0683419093707, 1096.5175322857917, 1098.3519723363254, 1109.1902910875106, 25280.87359563227, 25541.23376298714, 25542.616860747105, 25548.616770748453, 25790.871045645028, 1188.6374655729912, 1196.5034510678145, 1198.856137263534, 1202.482932339085, 1206.6802297391023, 17180.969141851278, 17302.712484627882, 17805.376811811526, 17967.820321796877, 18025.54936126581, 264661.0, 265112.0, 265336.0, 265400.0, 266184.0, 61110.69444652748, 61170.08244876331, 61389.0, 61539.692301538205, 61579.69210153921, 1442.4405067287614, 1446.3925151436422, 1476.7784832275245, 1482.1107335598554, 1487.0780116327946, 29555.55666665045, 30105.0, 30121.69878301189, 30550.541741874335, 30794.230144246572, 39985.60014399935, 40268.59731402648, 40311.3953290695, 40314.798426007685, 40382.0, 228474.0, 228857.0, 231303.0, 234159.0, 237537.0, 34991.30017399689, 35587.82206089057, 36776.0, 37103.0, 38609.80695096619, 48724.512754872, 49148.50851491439, 49268.2609760861, 49314.26028609502, 49535.504644953086, 35724.0, 36122.819385902905, 36218.0, 36291.27417451689, 36428.089297767765, 35657.46513802347, 35672.64327356693, 35862.820685896404, 35881.82059089688, 36542.63457365392, 42820.78589607032, 42872.57127428811, 43031.0, 43124.353134702375, 43257.56742432535, 34840.12899677528, 34884.476732849536, 34980.47529287012, 35110.82444587761, 35496.290074198885, 26115.347116322246, 26879.731202687723, 26923.596146057433, 27295.727042730112, 27329.86335068312], "value": 18382.60881040685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.2767387624039, 608.1425190481422, 611.5657882903135, 612.1796792298321, 631.9747210111594, 22952.311430657064, 23232.303030909057, 24177.879110604466, 24279.878600606993, 24280.271591852274, 23141.30576082716, 23456.413589660267, 23483.647745283834, 23534.88232558839, 23594.76405235947, 6968.581885086898, 7098.467614928875, 7101.893471597904, 7115.39519140871, 7132.786016419515, 6264.0, 6846.281140480252, 6874.27820078892, 6913.032175495435, 6999.475039372042, 6819.079424277734, 6840.486963477759, 6841.418479429254, 6861.519693621449, 6885.070515480396, 6800.149981252343, 6814.591124532494, 6814.591124532519, 6862.965685171592, 6875.48433867462, 6379.681015949184, 6392.296847346788, 6417.422431981097, 6421.51838612106, 6424.357564243585, 30881.536776948364, 31153.844230778926, 31193.220169495944, 31276.37447251065, 31559.211019724462, 2238.88805559723, 2273.4316420894775, 2274.238130226376, 2289.0386037864137, 2295.690081838947, 20855.270065547786, 21403.78596214049, 21410.678839817414, 21445.571088578297, 21447.463813404633, 2468.456939473313, 2518.659980902573, 2566.8331558448826, 2608.4261462478225, 2622.265765585639, 155771.0, 159109.0, 160255.0, 163834.1808290963, 164430.0, 15609.0, 16016.0, 16664.83335166657, 16960.57598560021, 17051.147442628066, 25450.236492905242, 26212.0, 26249.212523624323, 26320.73679263221, 26363.73636263651, 10660.20048496366, 10793.892061079288, 10820.513076911559, 10965.396903170402, 11032.779344413068, 9840.507974601242, 9865.605375785031, 9908.405495670282, 9979.900200998043, 10010.54952527138, 10077.364412370245, 10109.635199248154, 10145.64490242838, 10216.6424175155, 10250.794984100425, 2786.2664030199226, 2863.3700585871075, 2922.649282086163, 2937.7649788016906, 2942.6321709786275, 1016.7864748402918, 1054.984175237372, 1064.6646306413454, 1084.4415126210008, 1085.8425528298353, 21816.672749908765, 22216.333509994725, 22416.887915560645, 22571.661425078637, 22808.543829123326, 1080.2762149359792, 1123.0790751583622, 1127.937963412004, 1135.4379582106744, 1142.651491295163, 11586.188966772414, 12166.330851803059, 12176.878231217574, 12188.0, 12210.450529726184, 634996.0, 638084.0, 648816.0, 649622.0, 657556.0, 141731.0, 142589.28705356407, 144820.0, 144911.0, 145149.27425362804, 1341.9060665753498, 1349.4197495077015, 1372.2315503317975, 1376.1192836584594, 1379.558541266785, 19640.901795490932, 19670.508237294183, 19830.50423739418, 19831.0, 19879.0, 58990.41009589849, 61826.69086654538, 62051.0, 63243.0, 66471.33528664651, 81386.0, 81538.0, 81794.0, 84011.15988840278, 84436.57781711298, 15935.521934341989, 16292.429764958644, 16456.506304810875, 16468.75296870524, 16473.258703358137, 25452.363690907874, 25564.48871022606, 25862.482750344512, 25903.740962590135, 25945.22164335073, 19875.701864472332, 19986.70019949731, 20125.094370753643, 20592.27927022547, 20772.169113235905, 17448.389306374214, 17631.735523966894, 17743.733843992093, 18131.728024079912, 18373.265069397075, 20845.166193352095, 21165.6825147626, 21237.7876221242, 21526.138954441645, 21533.353999380044, 15784.763228551352, 15880.285387157837, 16013.519594412186, 16015.95896266739, 16047.839521604634, 20144.49638759043, 20437.182512699324, 20569.382918512467, 20912.790872091085, 20934.0], "value": 13136.850895180225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.7345741037907, 1483.295434668532, 1488.6576087499882, 1491.1723993183778, 1520.635047588579, 16313.265903034362, 16993.575160620992, 17012.0, 17051.573710657223, 17130.0, 17180.656386872255, 17486.38797642083, 17501.3874514392, 17538.29846806126, 17560.209790559424, 2886.2207204054894, 2943.970560294402, 2947.4989251827133, 2948.39557890633, 2953.7341639252463, 2837.361593641435, 2901.637295338083, 2909.519929211688, 2910.301527633374, 2911.606933064041, 2885.3507960708775, 2895.102518219348, 2904.651441826973, 2907.055207057704, 2923.5760814681857, 2848.2594525423438, 2853.2581528802452, 2870.669872964594, 2878.208492664534, 2882.682904880472, 2690.8294891721966, 2693.9730602693917, 2709.0382914065617, 2709.1059950216577, 2714.4571085782923, 16084.195790210442, 16482.67034659312, 16528.421505247377, 16534.0, 16559.6688066238, 8579.828403431959, 8851.822963540757, 8869.73390798277, 8876.511791851446, 8878.955605221998, 5548.722563871831, 5780.277465316835, 5784.566157538202, 5822.0, 5912.231409916726, 2095.769465358809, 2107.115011695076, 2107.4520624637553, 2148.967765483519, 2154.4613846538364, 29538.409231815458, 30192.396152076835, 30195.0, 30771.0, 31029.534556981664, 7438.7024519019715, 7440.181580026193, 7492.0, 7622.656980435893, 7651.426143039294, 19709.901450492656, 19748.70376944347, 19758.50603734918, 19780.802191978182, 19801.0, 8622.396432249683, 8763.430377025474, 8767.649294028295, 8772.473651580925, 8793.164649358301, 7864.0, 8026.0, 8077.959610201911, 8100.068492123363, 8100.635471403801, 5684.715764211773, 5766.88466230673, 5793.15999180125, 5910.8817823643285, 5921.851953701106, 1677.6057626457773, 1682.8990260584403, 1701.4215166843333, 1704.1905095079737, 1721.4835549335148, 983.8081574092984, 1008.0826447932346, 1012.473513772834, 1017.7862648843677, 1030.1810061001522, 9744.366616169926, 9793.706188814347, 9911.157551608194, 10000.149987251165, 10169.288149829441, 1043.3322673488974, 1098.1105304703217, 1114.966551003455, 1121.2767764791827, 1127.6504283672089, 6213.96893015532, 6291.622502649856, 6385.744570217233, 6440.77457289002, 6512.5441219115155, 24265.150719724727, 24727.38181545476, 25411.49177016449, 25496.49007019849, 25606.615900761502, 24836.37909052252, 25087.74912250854, 25396.746032539806, 25443.0, 25465.61801572978, 11527.654170374903, 11563.07495400366, 11637.301761894314, 12466.626001219978, 12654.114212005072, 10240.436775977094, 10480.790384192425, 10496.212784041074, 10598.788024239318, 11018.834717479405, 20313.085911133738, 20407.265382442063, 20864.165433382495, 20872.895635522334, 21555.2455664051, 21613.351599452042, 21957.23149689817, 22055.44861378414, 22227.333180004625, 22259.443513912283, 15318.540443786704, 15691.293891774669, 15776.290066947244, 15785.763213551576, 15788.447404340794, 15724.371025158865, 15724.685506289581, 15880.0, 15903.761443578123, 15915.204239788196, 12632.2420654761, 12777.552785652457, 12933.676658083623, 13077.215367078006, 13206.075574709677, 12390.132690711564, 12479.93760031194, 12617.49530018789, 12626.053046021401, 12879.098463107492, 10789.028987391173, 10831.566737330419, 10849.077828384676, 10918.399488028235, 10944.890551094388, 8578.78553036179, 8608.053114157563, 8610.65557377698, 8683.131686831266, 8804.383693141419, 8906.376553641183, 8974.596143173443, 8986.0, 9036.728898133066, 9058.63765449401], "value": 7553.845577339959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.7323864828938, 562.8705397758514, 574.7126436781609, 576.6194311754242, 579.4958386204003, 6781.898271525931, 6816.113905192325, 6828.760993365233, 6917.4466042716585, 6928.584284942907, 6722.865542689144, 6793.35463131003, 6797.286284940084, 6806.523543351967, 6816.898311268374, 5466.371367292752, 5504.339479262474, 5522.392536820947, 5527.585431092664, 5546.805861794838, 4940.716378997225, 5223.764930578133, 5238.947610523884, 5288.4711528847, 5453.291072160633, 5213.139831927728, 5216.921746173811, 5250.238715386266, 5277.656952298088, 5320.658910079572, 5199.246109314128, 5230.0, 5234.6335756497065, 5248.168836749175, 5272.182811664198, 4671.135839869601, 4696.929546056812, 4712.128256272601, 4752.168370535177, 4758.1673207188605, 6503.15458990333, 6572.338203027782, 6574.276829548794, 6612.570182938141, 6632.403083722488, 6108.725107370179, 6175.197224360849, 6203.7828675996125, 6234.87530249397, 6287.371262873722, 7039.838426659595, 7095.751648692322, 7114.395276401512, 7136.469236341824, 7160.964195179043, 5262.815801446969, 5318.707471089088, 5321.068812957756, 5326.440723723992, 5371.838844834661, 7200.711971521133, 7278.854422911565, 7334.1565719942355, 7464.036415783497, 7485.026946496921, 5421.593380496479, 5449.972750136224, 5465.890682186334, 5494.340679118532, 5501.862453438696, 5482.916491733115, 5518.641288316327, 5527.640703354349, 5533.501984821385, 5580.525655319343, 6144.201253837062, 6173.69131543421, 6225.190725205694, 6238.875222495525, 6271.874562508724, 7077.0, 7131.786046418616, 7134.143902731602, 7151.427885769126, 7207.603581802946, 1900.4013735673218, 1920.5294702797903, 1932.3140285198551, 1936.1190658250462, 1953.5506833428392, 1287.3498883063992, 1315.7171208190284, 1338.3241463061286, 1357.6402253402857, 1365.4265208612408, 6176.8764624707255, 6177.722002509898, 6221.782237621662, 6262.749490020348, 6279.246490421087, 7047.260037695968, 7120.964395177991, 7211.855762884713, 7245.239249878687, 7277.854442911218, 6249.281562520318, 6254.499640028786, 6271.749130034747, 6309.62142271456, 6339.873202535923, 3815.8473661053804, 3822.541295044557, 3828.0, 3848.7690738555775, 3863.4011728182177, 7092.184398794101, 7141.14306283239, 7142.892856607155, 7168.605726684978, 7175.390091842148, 7398.89476261378, 7469.551826890404, 7492.962535187289, 7542.585157816373, 7576.659050342638, 7028.0, 7043.168776118144, 7115.252898445692, 7128.572285662981, 7145.606991615407, 7224.313690199423, 7273.890571734138, 7275.1997280298065, 7277.59973201479, 7340.26597340283, 7156.391706704989, 7176.354128128493, 7243.45674074436, 7321.63391830417, 7336.96331518339, 7018.33325834045, 7050.471214659024, 7050.682719277747, 7076.646167691698, 7112.608806515691, 5470.64440811346, 5475.370332411664, 5479.3972663007835, 5496.31296087989, 5499.3675727291875, 7024.438044956289, 7049.894251586128, 7276.636168191675, 7361.521501102411, 7379.281057180728, 6959.338862808025, 7000.369966703021, 7037.0, 7068.717251310096, 7089.574625522485, 7019.2629773873, 7025.156981162088, 7041.647917604202, 7042.718291268292, 7064.611446370499, 6895.6552172390175, 6999.160100787938, 7033.366996970297, 7037.964810175917, 7039.436845052486, 6983.1620205575655, 7043.36609705129, 7123.786286411416, 7132.607706576188, 7174.964125179341, 6779.186497620317, 6799.5920244785475, 6804.693788779616, 6935.549189302679, 6944.722211111499], "value": 5478.489150085876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [959.3092973059395, 963.8168747937892, 992.8312186928222, 998.2912132386006, 1007.6422869881189, 20159.798402015975, 20399.99999999998, 20454.795452045477, 20552.89723551382, 23000.769992300073, 21367.14531418745, 21853.781462185372, 21867.343979680594, 21871.234506792265, 21916.561668766655, 1065.2170654568886, 1088.1784252889097, 1093.3439936038392, 1094.1301665176163, 1094.409019129671, 1046.8272734998716, 1069.5507886687571, 1086.3047649504324, 1090.8909109089068, 1095.0418383914075, 1130.1693255457233, 1132.3092913322866, 1133.9036181924546, 1135.0862555642705, 1135.3074624479102, 1135.2167004766768, 1135.3131355529868, 1135.5855112883737, 1136.1138312116561, 1140.9600663976762, 833.6998680475024, 833.8999320081629, 833.954132522711, 834.5368320582074, 837.3217693668088, 19918.90040549788, 20185.091670874845, 20644.0, 20946.790532094637, 21208.787912120835, 21946.231881884058, 22030.88984555083, 22195.889020554954, 22197.335199859914, 22641.660375094387, 18315.816841831544, 18504.0, 18768.71846922297, 18812.34156804519, 18922.3377181798, 3949.565547789741, 3967.0677390813134, 3971.801409929521, 3974.602539746002, 3974.841006359742, 155594.0, 157227.0, 157847.21076394658, 158056.0, 158154.0, 16812.24344904482, 17617.207225674876, 17761.378351757627, 17996.55008624795, 18191.727124092886, 33577.16057098592, 33757.66242337594, 33798.15504612404, 34414.82792586021, 34428.0, 8549.829003420022, 8838.911610883808, 9095.636174553076, 9403.529823508798, 9710.17463515609, 4625.95374046262, 4712.081144176853, 4717.127331443694, 4717.787699553528, 4735.052989402134, 5724.427557244326, 5802.071668533014, 5820.388859169726, 5822.970885145632, 5878.235829342244, 1186.2170967161805, 1202.8616709078392, 1220.2434490615874, 1223.0582451512287, 1225.8161275808523, 734.7612026091541, 756.7086671631462, 758.2417582417582, 761.9123800762873, 773.4663082473076, 12986.935065324613, 13684.52104176349, 14082.647933801532, 14347.713045739027, 14406.42374305037, 747.1445195251515, 764.6100488750666, 764.8355603545265, 774.5933384972934, 780.6292011294703, 6367.7452901884335, 6370.58591191571, 6414.230292364946, 6459.418652321314, 6515.185601799775, 128393.35803320924, 128946.0, 129763.35118324347, 131038.0, 137320.0, 112491.0, 114066.50890521858, 114426.0, 116423.08942276341, 118809.0, 96550.0, 98409.0, 98836.0, 100070.0, 100720.49639751755, 12045.0, 12093.455794489093, 12095.39523023863, 12152.878471215176, 12458.0, 48799.5120048795, 49258.75370623124, 49643.50356496389, 50346.2448063272, 50554.49445505498, 64379.67810160919, 64548.0, 65113.674431629435, 65291.0, 65316.67341663261, 16287.755683664991, 16361.918190408971, 16677.416290429777, 16752.246148923085, 18822.52943676419, 23014.309570712907, 23131.88434057886, 23151.421214469774, 23286.417839554146, 23382.064717411115, 19322.0, 19569.315073972342, 19603.509912252306, 19614.901925490853, 19826.504337391103, 19105.33131340452, 19221.615567688288, 19258.90370548138, 19315.323963661205, 19359.3224237151, 18922.621547568695, 19048.04759762034, 19116.71324930155, 19176.712349314494, 19282.421527354203, 13877.167369957835, 14296.0, 14332.211728355041, 15083.849161508684, 15134.545963620669, 15488.434123705603, 15903.891303262179, 16059.19704014818, 16166.353345866033, 16193.75709364337], "value": 10026.889010437648, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 98.0, 106.0, 104.0, 105.0, 107.0, 98.0, 105.0, 108.0], "value": 103.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 154.0, 181.0, 112.0, 140.0, 148.0, 114.0, 165.0, 117.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 161.0, 162.0, 162.0, 162.0, 160.0, 167.0, 165.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 173.0, 73.0, 72.0, 72.0, 88.0, 97.0, 73.0], "value": 86.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 126.0, 79.0, 77.0, 78.0, 123.0, 81.0, 78.0, 126.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 150.0, 149.0, 149.0, 151.0, 151.0, 150.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 48.0, 43.0, 43.0, 43.0, 43.0, 43.0, 43.0, 45.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0, 36.0], "value": 36.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 74.0, 73.0, 71.0, 75.0, 72.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 120.0, 114.0, 110.0, 110.0, 109.0, 115.0, 126.0, 114.0, 155.0], "value": 118.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 154.0, 164.0, 166.0, 156.0, 157.0, 153.0, 156.0, 153.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 66.0, 61.0, 60.0, 59.0, 60.0, 62.0, 57.0], "value": 60.3, "unit": "score"}]}]} 11:54:36 INFO - Return code: 0 11:54:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:54:36 INFO - # TBPL SUCCESS # 11:54:36 INFO - Running post-action listener: _package_coverage_data 11:54:36 INFO - Running post-action listener: _resource_record_post_action 11:54:36 INFO - [mozharness: 2017-09-01 18:54:36.169515Z] Finished run-tests step (success) 11:54:36 INFO - Running post-run listener: _resource_record_post_run 11:54:36 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 394461184; Read time: 396; Write time: 282736 11:54:36 INFO - TinderboxPrint: CPU usage
13.1% 11:54:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 396 11:54:36 INFO - TinderboxPrint: I/O write bytes / time
394,461,184 / 282,736 11:54:36 INFO - TinderboxPrint: CPU idle
8,225.5 (86.9%) 11:54:36 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 11:54:36 INFO - TinderboxPrint: Swap in / out
0 / 0 11:54:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115789824; Read time: 200; Write time: 86028 11:54:36 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:54:36 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278671360; Read time: 196; Write time: 196708 11:54:36 INFO - Running post-run listener: _upload_blobber_files 11:54:36 INFO - Blob upload gear active. 11:54:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:54:36 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:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:54:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:54:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:54:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:54:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:40 INFO - (blobuploader) - INFO - Done attempting. 11:54:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:54:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:54:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:41 INFO - (blobuploader) - INFO - Done attempting. 11:54:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:54:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:42 INFO - (blobuploader) - INFO - Done attempting. 11:54:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:54:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:54:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:54:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:54:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:54:43 INFO - (blobuploader) - INFO - Done attempting. 11:54:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:54:43 INFO - Return code: 0 11:54:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:54:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:54:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c906e67cada8ee0eef7daa7f187dd60c6cf0c6ff147df576356a444866afe27b0747937db8709d311e97a7e44d74a858a6b0ae3216c7a054fbdaea5c5e8306bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c526b71d277a38cae9e75fc57e2036e76505841ea88d69e5237f30466e9434c4223c79b381c459730409d9b9a3f9123f898b44a4bc0ffe3fcac8ca92c32fe8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e429ccfc42ee8e10a3a4d9c585d9d90bb558f38b8c518ff2bebf7db102d7317f5f0175201e716b8b71d09302de380069a58ff9437791ec350e623009db3a89fb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c305e2c8f6ee652fce53a97255638b11a27020c8670a38e05fd21b8226fd85f76e1f3333bea2244aec50dc23d9cd01d88627709237e56d18160916810450617"} 11:54:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:54:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:54:43 INFO - Contents: 11:54:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c906e67cada8ee0eef7daa7f187dd60c6cf0c6ff147df576356a444866afe27b0747937db8709d311e97a7e44d74a858a6b0ae3216c7a054fbdaea5c5e8306bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c526b71d277a38cae9e75fc57e2036e76505841ea88d69e5237f30466e9434c4223c79b381c459730409d9b9a3f9123f898b44a4bc0ffe3fcac8ca92c32fe8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e429ccfc42ee8e10a3a4d9c585d9d90bb558f38b8c518ff2bebf7db102d7317f5f0175201e716b8b71d09302de380069a58ff9437791ec350e623009db3a89fb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c305e2c8f6ee652fce53a97255638b11a27020c8670a38e05fd21b8226fd85f76e1f3333bea2244aec50dc23d9cd01d88627709237e56d18160916810450617"} 11:54:43 INFO - Running post-run listener: copy_logs_to_upload_dir 11:54:43 INFO - Copying logs to upload dir... 11:54:43 INFO - mkdir: /builds/slave/test/build/upload/logs 11:54:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.321595 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-01 11:54:43.342933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 11:54:43.345142) ========= 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=199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874 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/sha512/c906e67cada8ee0eef7daa7f187dd60c6cf0c6ff147df576356a444866afe27b0747937db8709d311e97a7e44d74a858a6b0ae3216c7a054fbdaea5c5e8306bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c526b71d277a38cae9e75fc57e2036e76505841ea88d69e5237f30466e9434c4223c79b381c459730409d9b9a3f9123f898b44a4bc0ffe3fcac8ca92c32fe8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e429ccfc42ee8e10a3a4d9c585d9d90bb558f38b8c518ff2bebf7db102d7317f5f0175201e716b8b71d09302de380069a58ff9437791ec350e623009db3a89fb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c305e2c8f6ee652fce53a97255638b11a27020c8670a38e05fd21b8226fd85f76e1f3333bea2244aec50dc23d9cd01d88627709237e56d18160916810450617"} build_url:https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/c7Rs-MIYRLm3AsKapwL0Sw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c906e67cada8ee0eef7daa7f187dd60c6cf0c6ff147df576356a444866afe27b0747937db8709d311e97a7e44d74a858a6b0ae3216c7a054fbdaea5c5e8306bf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c526b71d277a38cae9e75fc57e2036e76505841ea88d69e5237f30466e9434c4223c79b381c459730409d9b9a3f9123f898b44a4bc0ffe3fcac8ca92c32fe8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e429ccfc42ee8e10a3a4d9c585d9d90bb558f38b8c518ff2bebf7db102d7317f5f0175201e716b8b71d09302de380069a58ff9437791ec350e623009db3a89fb", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c305e2c8f6ee652fce53a97255638b11a27020c8670a38e05fd21b8226fd85f76e1f3333bea2244aec50dc23d9cd01d88627709237e56d18160916810450617"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 11:54:43.385859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:54:43.386193) ========= 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=199fb4c72b90437b990b419b000001c5-1504290836.117298-2019106874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 11:54:43.465698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 11:54:43.466211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 11:54:43.466504) ========= ========= Total master_lag: 0.26 =========