builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1503184760.48 results: success (0) revision: 5ca5691372cb432ec1fa4693ca608a30858226de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.475798) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.476230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.476521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.520296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.520711) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-19 16:19:21-- 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% 53.4M=0s 2017-08-19 16:19:21 (53.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121509 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.672997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.673271) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019779 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.742572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:20.742882) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ca5691372cb432ec1fa4693ca608a30858226de --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 5ca5691372cb432ec1fa4693ca608a30858226de --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=a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-19 16:19:22,083 truncating revision to first 12 chars 2017-08-19 16:19:22,083 Setting DEBUG logging. 2017-08-19 16:19:22,083 attempt 1/10 2017-08-19 16:19:22,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ca5691372cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-19 16:19:22,492 unpacking tar archive at: mozilla-central-5ca5691372cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.766486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:21.530190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:21.530483) ========= script_repo_revision: 5ca5691372cb432ec1fa4693ca608a30858226de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:21.531127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:21.531395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 16:19:21.548616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-19 16:19:21.548930) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:19:23 INFO - MultiFileLogger online at 20170819 16:19:23 in /builds/slave/test 16:19:23 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 16:19:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:19:23 INFO - {'append_to_log': False, 16:19:23 INFO - 'base_work_dir': '/builds/slave/test', 16:19:23 INFO - 'blob_upload_branch': 'Firefox', 16:19:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:19:23 INFO - 'branch': 'Firefox', 16:19:23 INFO - 'buildbot_json_path': 'buildprops.json', 16:19:23 INFO - 'code_coverage': False, 16:19:23 INFO - 'config_files': ('talos/linux_config.py',), 16:19:23 INFO - 'default_actions': ('clobber', 16:19:23 INFO - 'read-buildbot-config', 16:19:23 INFO - 'download-and-extract', 16:19:23 INFO - 'populate-webroot', 16:19:23 INFO - 'create-virtualenv', 16:19:23 INFO - 'install', 16:19:23 INFO - 'setup-mitmproxy', 16:19:23 INFO - 'run-tests'), 16:19:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:19:23 INFO - 'disable_ccov_upload': False, 16:19:23 INFO - 'download_minidump_stackwalk': True, 16:19:23 INFO - 'download_symbols': 'ondemand', 16:19:23 INFO - 'enable_stylo': False, 16:19:23 INFO - 'enable_webrender': False, 16:19:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:19:23 INFO - 'tooltool.py': '/tools/tooltool.py', 16:19:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:19:23 INFO - '/tools/misc-python/virtualenv.py')}, 16:19:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:19:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:19:23 INFO - 'gecko_profile': False, 16:19:23 INFO - 'gecko_profile_interval': 0, 16:19:23 INFO - 'installer_path': 'installer.exe', 16:19:23 INFO - 'log_level': 'info', 16:19:23 INFO - 'log_name': 'talos', 16:19:23 INFO - 'log_to_console': True, 16:19:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:19:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:19:23 INFO - 'opt_config_files': (), 16:19:23 INFO - 'pip_index': False, 16:19:23 INFO - 'suite': 'dromaeojs-e10s', 16:19:23 INFO - 'system_bits': '32', 16:19:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:19:23 INFO - 'title': 'talos-linux64-ix-064', 16:19:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:19:23 INFO - 'use_talos_json': True, 16:19:23 INFO - 'verify': 'False', 16:19:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:19:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:19:23 INFO - 'work_dir': 'build'} 16:19:23 INFO - [mozharness: 2017-08-19 23:19:23.023627Z] Running clobber step. 16:19:23 INFO - Running pre-action listener: _resource_record_pre_action 16:19:23 INFO - Running main action method: clobber 16:19:23 INFO - rmtree: /builds/slave/test/build 16:19:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:19:24 INFO - Running post-action listener: _resource_record_post_action 16:19:24 INFO - [mozharness: 2017-08-19 23:19:24.547166Z] Finished clobber step (success) 16:19:24 INFO - [mozharness: 2017-08-19 23:19:24.547263Z] Running read-buildbot-config step. 16:19:24 INFO - Running pre-action listener: _resource_record_pre_action 16:19:24 INFO - Running main action method: read_buildbot_config 16:19:24 INFO - Using buildbot properties: 16:19:24 INFO - { 16:19:24 INFO - "project": "", 16:19:24 INFO - "product": "firefox", 16:19:24 INFO - "who": "philringnalda@gmail.com", 16:19:24 INFO - "installer_path": "public/build/target.tar.bz2", 16:19:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:19:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:19:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:19:24 INFO - "stage_platform": "linux64-stylo", 16:19:24 INFO - "basedir": "/builds/slave/test", 16:19:24 INFO - "buildnumber": 276, 16:19:24 INFO - "platform": "ubuntu64_hw_stylo", 16:19:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:19:24 INFO - "slavebuilddir": "test", 16:19:24 INFO - "taskId": "HwfoeqTiTCOd5-o0RjDgMQ", 16:19:24 INFO - "branch": "mozilla-central", 16:19:24 INFO - "script_repo_revision": "production", 16:19:24 INFO - "revision": "5ca5691372cb432ec1fa4693ca608a30858226de", 16:19:24 INFO - "slavename": "talos-linux64-ix-064", 16:19:24 INFO - "repo_path": "mozilla-central" 16:19:24 INFO - } 16:19:24 INFO - Finding installer, test and symbols from parent task. 16:19:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HwfoeqTiTCOd5-o0RjDgMQ'}, attempt #1 16:19:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HwfoeqTiTCOd5-o0RjDgMQ'}, attempt #1 16:19:25 INFO - Task dependencies: W9C2vB0BSYGWfd0EmSMW5Q 16:19:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q'}, attempt #1 16:19:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2 16:19:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.test_packages.json 16:19:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.crashreporter-symbols.zip 16:19:25 INFO - Running post-action listener: _resource_record_post_action 16:19:25 INFO - [mozharness: 2017-08-19 23:19:25.891977Z] Finished read-buildbot-config step (success) 16:19:25 INFO - [mozharness: 2017-08-19 23:19:25.892195Z] Running download-and-extract step. 16:19:25 INFO - Running pre-action listener: _resource_record_pre_action 16:19:25 INFO - Running main action method: download_and_extract 16:19:25 INFO - mkdir: /builds/slave/test/build/tests 16:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:25 INFO - trying https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.test_packages.json 16:19:25 INFO - Downloading https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:19:26 INFO - Downloaded 989 bytes. 16:19:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:19:26 INFO - Using the following test package requirements: 16:19:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:19:26 INFO - u'common': [u'target.common.tests.zip'], 16:19:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:19:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:19:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:19:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:19:26 INFO - u'mozbase': [u'target.common.tests.zip'], 16:19:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:19:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:19:26 INFO - u'web-platform': [u'target.common.tests.zip', 16:19:26 INFO - u'target.web-platform.tests.tar.gz'], 16:19:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:19:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:19:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.common.tests.zip 16:19:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:19:26 INFO - Fetch https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.common.tests.zip into memory 16:19:28 INFO - Content-Length response header: 54005772 16:19:28 INFO - Bytes received: 54005772 16:19:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:19:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.common.tests.zip 16:19:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:19:38 INFO - Fetch https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.common.tests.zip into memory 16:19:40 INFO - Content-Length response header: 54005772 16:19:40 INFO - Bytes received: 54005772 16:19:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.talos.tests.zip 16:19:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:19:51 INFO - Fetch https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.talos.tests.zip into memory 16:19:52 INFO - Content-Length response header: 14496256 16:19:52 INFO - Bytes received: 14496256 16:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:53 INFO - trying https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2 16:19:53 INFO - Downloading https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:19:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:19:54 INFO - Downloaded 62072037 bytes. 16:19:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2 16:19:54 INFO - mkdir: /builds/slave/test/properties 16:19:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:54 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:54 INFO - Contents: 16:19:54 INFO - build_url:https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2 16:19:54 INFO - Running post-action listener: _resource_record_post_action 16:19:54 INFO - Running post-action listener: find_tests_for_verification 16:19:54 INFO - Running post-action listener: set_extra_try_arguments 16:19:54 INFO - [mozharness: 2017-08-19 23:19:54.167635Z] Finished download-and-extract step (success) 16:19:54 INFO - [mozharness: 2017-08-19 23:19:54.167733Z] Running populate-webroot step. 16:19:54 INFO - Running pre-action listener: _resource_record_pre_action 16:19:54 INFO - Running main action method: populate_webroot 16:19:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:19:54 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:19:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:19:54 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:19:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:54 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'tests': ['damp', 'tps']}, 16:19:54 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['damp', 'tps']}, 16:19:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:19:54 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:19:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:19:54 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:19:54 INFO - 'other-e10s': {'tests': ['a11yr', 16:19:54 INFO - 'ts_paint', 16:19:54 INFO - 'tpaint', 16:19:54 INFO - 'sessionrestore', 16:19:54 INFO - 'sessionrestore_many_windows', 16:19:54 INFO - 'sessionrestore_no_auto_restore', 16:19:54 INFO - 'tabpaint']}, 16:19:54 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['a11yr', 16:19:54 INFO - 'ts_paint', 16:19:54 INFO - 'tpaint', 16:19:54 INFO - 'sessionrestore', 16:19:54 INFO - 'sessionrestore_many_windows', 16:19:54 INFO - 'sessionrestore_no_auto_restore', 16:19:54 INFO - 'tabpaint']}, 16:19:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:19:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:19:54 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['bloom_basic_singleton']}, 16:19:54 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['bloom_basic']}, 16:19:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:19:54 INFO - 'tsvgr_opacity', 16:19:54 INFO - 'tart', 16:19:54 INFO - 'tscrollx', 16:19:54 INFO - 'tsvg_static']}, 16:19:54 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['tsvgx', 16:19:54 INFO - 'tsvgr_opacity', 16:19:54 INFO - 'tart', 16:19:54 INFO - 'tscrollx', 16:19:54 INFO - 'tsvg_static']}, 16:19:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:19:54 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'talos_options': ['--stylo'], 16:19:54 INFO - 'tests': ['tp5o']}, 16:19:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:54 INFO - 'talos_options': ['--mitmproxy', 16:19:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:54 INFO - '--firstNonBlankPaint'], 16:19:54 INFO - 'tests': ['tp6_google', 16:19:54 INFO - 'tp6_youtube', 16:19:54 INFO - 'tp6_amazon', 16:19:54 INFO - 'tp6_facebook']}, 16:19:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:54 INFO - 'talos_options': ['--stylo', 16:19:54 INFO - '--mitmproxy', 16:19:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:54 INFO - '--firstNonBlankPaint'], 16:19:54 INFO - 'tests': ['tp6_google', 16:19:54 INFO - 'tp6_youtube', 16:19:54 INFO - 'tp6_amazon', 16:19:54 INFO - 'tp6_facebook']}, 16:19:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:54 INFO - 'talos_options': ['--stylo', 16:19:54 INFO - '--stylo-threads=1', 16:19:54 INFO - '--mitmproxy', 16:19:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:54 INFO - '--firstNonBlankPaint'], 16:19:54 INFO - 'tests': ['tp6_google', 16:19:54 INFO - 'tp6_youtube', 16:19:54 INFO - 'tp6_amazon', 16:19:54 INFO - 'tp6_facebook']}, 16:19:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'talos_options': ['--xperf_path', 16:19:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:54 INFO - 'tests': ['tp5n']}, 16:19:54 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:19:54 INFO - 'talos_options': ['--stylo', 16:19:54 INFO - '--xperf_path', 16:19:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:54 INFO - 'tests': ['tp5n']}}} 16:19:54 INFO - Running post-action listener: _resource_record_post_action 16:19:54 INFO - [mozharness: 2017-08-19 23:19:54.181986Z] Finished populate-webroot step (success) 16:19:54 INFO - [mozharness: 2017-08-19 23:19:54.182076Z] Running create-virtualenv step. 16:19:54 INFO - Running pre-action listener: _resource_record_pre_action 16:19:54 INFO - Running main action method: create_virtualenv 16:19:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:19:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:19:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:54 INFO - Using real prefix '/usr' 16:19:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:54 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:56 INFO - Installing pip.................done. 16:19:56 INFO - Return code: 0 16:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:19:56 INFO - Reading from file tmpfile_stdout 16:19:56 INFO - Output received: 16:19:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:19:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:56 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 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:19:57 INFO - Using env: {'DISPLAY': ':0', 16:19:57 INFO - 'HOME': '/home/cltbld', 16:19:57 INFO - 'LANG': 'en_US.UTF-8', 16:19:57 INFO - 'LANGUAGE': 'en_US:en', 16:19:57 INFO - 'LOGNAME': 'cltbld', 16:19:57 INFO - 'MAIL': '/var/mail/cltbld', 16:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:57 INFO - 'MOZ_NO_REMOTE': '1', 16:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:57 INFO - 'NO_EM_RESTART': '1', 16:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:57 INFO - 'PWD': '/builds/slave/test', 16:19:57 INFO - 'SHELL': '/bin/bash', 16:19:57 INFO - 'SHLVL': '1', 16:19:57 INFO - 'TERM': 'linux', 16:19:57 INFO - 'TMOUT': '86400', 16:19:57 INFO - 'USER': 'cltbld', 16:19:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:57 INFO - '_': '/tools/buildbot/bin/python'} 16:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:19:57 INFO - Cleaning up... 16:19:57 INFO - Return code: 0 16:19:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:19:57 INFO - Using env: {'DISPLAY': ':0', 16:19:57 INFO - 'HOME': '/home/cltbld', 16:19:57 INFO - 'LANG': 'en_US.UTF-8', 16:19:57 INFO - 'LANGUAGE': 'en_US:en', 16:19:57 INFO - 'LOGNAME': 'cltbld', 16:19:57 INFO - 'MAIL': '/var/mail/cltbld', 16:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:57 INFO - 'MOZ_NO_REMOTE': '1', 16:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:57 INFO - 'NO_EM_RESTART': '1', 16:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:57 INFO - 'PWD': '/builds/slave/test', 16:19:57 INFO - 'SHELL': '/bin/bash', 16:19:57 INFO - 'SHLVL': '1', 16:19:57 INFO - 'TERM': 'linux', 16:19:57 INFO - 'TMOUT': '86400', 16:19:57 INFO - 'USER': 'cltbld', 16:19:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:57 INFO - '_': '/tools/buildbot/bin/python'} 16:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:57 INFO - Downloading/unpacking psutil>=3.1.1 16:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:58 INFO - Installing collected packages: psutil 16:19:58 INFO - Running setup.py install for psutil 16:19:58 INFO - building 'psutil._psutil_linux' extension 16:19:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:19:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:19:58 INFO - building 'psutil._psutil_posix' extension 16:19:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:19:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:19:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:59 INFO - Successfully installed psutil 16:19:59 INFO - Cleaning up... 16:19:59 INFO - Return code: 0 16:19:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:19:59 INFO - Using env: {'DISPLAY': ':0', 16:19:59 INFO - 'HOME': '/home/cltbld', 16:19:59 INFO - 'LANG': 'en_US.UTF-8', 16:19:59 INFO - 'LANGUAGE': 'en_US:en', 16:19:59 INFO - 'LOGNAME': 'cltbld', 16:19:59 INFO - 'MAIL': '/var/mail/cltbld', 16:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:59 INFO - 'MOZ_NO_REMOTE': '1', 16:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:59 INFO - 'NO_EM_RESTART': '1', 16:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:59 INFO - 'PWD': '/builds/slave/test', 16:19:59 INFO - 'SHELL': '/bin/bash', 16:19:59 INFO - 'SHLVL': '1', 16:19:59 INFO - 'TERM': 'linux', 16:19:59 INFO - 'TMOUT': '86400', 16:19:59 INFO - 'USER': 'cltbld', 16:19:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:59 INFO - '_': '/tools/buildbot/bin/python'} 16:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:20:00 INFO - Installing collected packages: mozsystemmonitor 16:20:00 INFO - Running setup.py install for mozsystemmonitor 16:20:00 INFO - Successfully installed mozsystemmonitor 16:20:00 INFO - Cleaning up... 16:20:00 INFO - Return code: 0 16:20:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:20:00 INFO - Using env: {'DISPLAY': ':0', 16:20:00 INFO - 'HOME': '/home/cltbld', 16:20:00 INFO - 'LANG': 'en_US.UTF-8', 16:20:00 INFO - 'LANGUAGE': 'en_US:en', 16:20:00 INFO - 'LOGNAME': 'cltbld', 16:20:00 INFO - 'MAIL': '/var/mail/cltbld', 16:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:00 INFO - 'MOZ_NO_REMOTE': '1', 16:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:00 INFO - 'NO_EM_RESTART': '1', 16:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:00 INFO - 'PWD': '/builds/slave/test', 16:20:00 INFO - 'SHELL': '/bin/bash', 16:20:00 INFO - 'SHLVL': '1', 16:20:00 INFO - 'TERM': 'linux', 16:20:00 INFO - 'TMOUT': '86400', 16:20:00 INFO - 'USER': 'cltbld', 16:20:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:00 INFO - '_': '/tools/buildbot/bin/python'} 16:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:00 INFO - Downloading/unpacking jsonschema==2.5.1 16:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:20:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:20:02 INFO - warning: no files found matching '*.txt' 16:20:02 INFO - no previously-included directories found matching 'build' 16:20:02 INFO - no previously-included directories found matching 'dist' 16:20:02 INFO - no previously-included directories found matching '.git*' 16:20:02 INFO - Installing collected packages: jsonschema, functools32 16:20:02 INFO - Running setup.py install for functools32 16:20:02 INFO - warning: no files found matching '*.txt' 16:20:02 INFO - no previously-included directories found matching 'build' 16:20:02 INFO - no previously-included directories found matching 'dist' 16:20:02 INFO - no previously-included directories found matching '.git*' 16:20:02 INFO - Successfully installed jsonschema functools32 16:20:02 INFO - Cleaning up... 16:20:02 INFO - Return code: 0 16:20:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:20:02 INFO - Using env: {'DISPLAY': ':0', 16:20:02 INFO - 'HOME': '/home/cltbld', 16:20:02 INFO - 'LANG': 'en_US.UTF-8', 16:20:02 INFO - 'LANGUAGE': 'en_US:en', 16:20:02 INFO - 'LOGNAME': 'cltbld', 16:20:02 INFO - 'MAIL': '/var/mail/cltbld', 16:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:02 INFO - 'MOZ_NO_REMOTE': '1', 16:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:02 INFO - 'NO_EM_RESTART': '1', 16:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:02 INFO - 'PWD': '/builds/slave/test', 16:20:02 INFO - 'SHELL': '/bin/bash', 16:20:02 INFO - 'SHLVL': '1', 16:20:02 INFO - 'TERM': 'linux', 16:20:02 INFO - 'TMOUT': '86400', 16:20:02 INFO - 'USER': 'cltbld', 16:20:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:02 INFO - '_': '/tools/buildbot/bin/python'} 16:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:20:02 INFO - Cleaning up... 16:20:02 INFO - Return code: 0 16:20:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:20:02 INFO - Using env: {'DISPLAY': ':0', 16:20:02 INFO - 'HOME': '/home/cltbld', 16:20:02 INFO - 'LANG': 'en_US.UTF-8', 16:20:02 INFO - 'LANGUAGE': 'en_US:en', 16:20:02 INFO - 'LOGNAME': 'cltbld', 16:20:02 INFO - 'MAIL': '/var/mail/cltbld', 16:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:02 INFO - 'MOZ_NO_REMOTE': '1', 16:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:02 INFO - 'NO_EM_RESTART': '1', 16:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:02 INFO - 'PWD': '/builds/slave/test', 16:20:02 INFO - 'SHELL': '/bin/bash', 16:20:02 INFO - 'SHLVL': '1', 16:20:02 INFO - 'TERM': 'linux', 16:20:02 INFO - 'TMOUT': '86400', 16:20:02 INFO - 'USER': 'cltbld', 16:20:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:02 INFO - '_': '/tools/buildbot/bin/python'} 16:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:20:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:20:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:04 INFO - Downloading docopt-0.6.1.tar.gz 16:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:20:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:20:04 INFO - Running setup.py install for blobuploader 16:20:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:20:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:20:04 INFO - Running setup.py install for requests 16:20:04 INFO - Running setup.py install for docopt 16:20:05 INFO - Successfully installed blobuploader requests docopt 16:20:05 INFO - Cleaning up... 16:20:05 INFO - Return code: 0 16:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:05 INFO - Using env: {'DISPLAY': ':0', 16:20:05 INFO - 'HOME': '/home/cltbld', 16:20:05 INFO - 'LANG': 'en_US.UTF-8', 16:20:05 INFO - 'LANGUAGE': 'en_US:en', 16:20:05 INFO - 'LOGNAME': 'cltbld', 16:20:05 INFO - 'MAIL': '/var/mail/cltbld', 16:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:05 INFO - 'MOZ_NO_REMOTE': '1', 16:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:05 INFO - 'NO_EM_RESTART': '1', 16:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:05 INFO - 'PWD': '/builds/slave/test', 16:20:05 INFO - 'SHELL': '/bin/bash', 16:20:05 INFO - 'SHLVL': '1', 16:20:05 INFO - 'TERM': 'linux', 16:20:05 INFO - 'TMOUT': '86400', 16:20:05 INFO - 'USER': 'cltbld', 16:20:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:05 INFO - '_': '/tools/buildbot/bin/python'} 16:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:05 INFO - Running setup.py (path:/tmp/pip-wOIdxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:05 INFO - Running setup.py (path:/tmp/pip-gcdT8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:05 INFO - Running setup.py (path:/tmp/pip-_t3tSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:05 INFO - Running setup.py (path:/tmp/pip-FJS__e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:05 INFO - Running setup.py (path:/tmp/pip-7Fz9UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:05 INFO - Running setup.py (path:/tmp/pip-0JXmFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:05 INFO - Running setup.py (path:/tmp/pip-S0Jneq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:05 INFO - Running setup.py (path:/tmp/pip-gNI1U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:05 INFO - Running setup.py (path:/tmp/pip-rQLxJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:06 INFO - Running setup.py (path:/tmp/pip-DU0PaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:06 INFO - Running setup.py (path:/tmp/pip-7v95sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:06 INFO - Running setup.py (path:/tmp/pip-C9jwfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:06 INFO - Running setup.py (path:/tmp/pip-3NFLqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:06 INFO - Running setup.py (path:/tmp/pip-eerFZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:06 INFO - Running setup.py (path:/tmp/pip-0bLYYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:06 INFO - Running setup.py (path:/tmp/pip-b8Ayk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:06 INFO - Running setup.py (path:/tmp/pip-7dxzdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:20:06 INFO - Running setup.py install for manifestparser 16:20:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Running setup.py install for mozcrash 16:20:06 INFO - Running setup.py install for mozdebug 16:20:06 INFO - Running setup.py install for mozdevice 16:20:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for mozfile 16:20:07 INFO - Running setup.py install for mozhttpd 16:20:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for mozinfo 16:20:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for mozInstall 16:20:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for mozleak 16:20:07 INFO - Running setup.py install for mozlog 16:20:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for moznetwork 16:20:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for mozprocess 16:20:07 INFO - Running setup.py install for mozprofile 16:20:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:20:07 INFO - Running setup.py install for mozrunner 16:20:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:20:08 INFO - Running setup.py install for mozscreenshot 16:20:08 INFO - Running setup.py install for moztest 16:20:08 INFO - Running setup.py install for mozversion 16:20:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:20:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:20:08 INFO - Cleaning up... 16:20:08 INFO - Return code: 0 16:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:08 INFO - Using env: {'DISPLAY': ':0', 16:20:08 INFO - 'HOME': '/home/cltbld', 16:20:08 INFO - 'LANG': 'en_US.UTF-8', 16:20:08 INFO - 'LANGUAGE': 'en_US:en', 16:20:08 INFO - 'LOGNAME': 'cltbld', 16:20:08 INFO - 'MAIL': '/var/mail/cltbld', 16:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:08 INFO - 'MOZ_NO_REMOTE': '1', 16:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:08 INFO - 'NO_EM_RESTART': '1', 16:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:08 INFO - 'PWD': '/builds/slave/test', 16:20:08 INFO - 'SHELL': '/bin/bash', 16:20:08 INFO - 'SHLVL': '1', 16:20:08 INFO - 'TERM': 'linux', 16:20:08 INFO - 'TMOUT': '86400', 16:20:08 INFO - 'USER': 'cltbld', 16:20:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:08 INFO - '_': '/tools/buildbot/bin/python'} 16:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:08 INFO - Running setup.py (path:/tmp/pip-Rf492b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:08 INFO - Running setup.py (path:/tmp/pip-G83KWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:08 INFO - Running setup.py (path:/tmp/pip-5UM1m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:08 INFO - Running setup.py (path:/tmp/pip-33fwJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:08 INFO - Running setup.py (path:/tmp/pip-oOEdHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:08 INFO - Running setup.py (path:/tmp/pip-kGDnZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:09 INFO - Running setup.py (path:/tmp/pip-ajGuM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:09 INFO - Running setup.py (path:/tmp/pip-GZcASQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:09 INFO - Running setup.py (path:/tmp/pip-7mWBOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:09 INFO - Running setup.py (path:/tmp/pip-vdVTjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:09 INFO - Running setup.py (path:/tmp/pip-JqZkDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:09 INFO - Running setup.py (path:/tmp/pip-HyNJ_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:09 INFO - Running setup.py (path:/tmp/pip-7lVT7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:09 INFO - Running setup.py (path:/tmp/pip-w6saTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:09 INFO - Running setup.py (path:/tmp/pip-qykYUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:09 INFO - Running setup.py (path:/tmp/pip-NFkknO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:09 INFO - Running setup.py (path:/tmp/pip-YcKdaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:20:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:10 INFO - Downloading blessings-1.6.tar.gz 16:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:20:11 INFO - Installing collected packages: blessings 16:20:11 INFO - Running setup.py install for blessings 16:20:11 INFO - Successfully installed blessings 16:20:11 INFO - Cleaning up... 16:20:11 INFO - Return code: 0 16:20:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:11 INFO - Reading from file tmpfile_stdout 16:20:11 INFO - Current package versions: 16:20:11 INFO - argparse == 1.2.1 16:20:11 INFO - blessings == 1.6 16:20:11 INFO - blobuploader == 1.2.4 16:20:11 INFO - docopt == 0.6.1 16:20:11 INFO - functools32 == 3.2.3-2 16:20:11 INFO - jsonschema == 2.5.1 16:20:11 INFO - manifestparser == 1.1 16:20:11 INFO - mozInstall == 1.13 16:20:11 INFO - mozcrash == 1.0 16:20:11 INFO - mozdebug == 0.1 16:20:11 INFO - mozdevice == 0.51 16:20:11 INFO - mozfile == 1.2 16:20:11 INFO - mozhttpd == 0.7 16:20:11 INFO - mozinfo == 0.10 16:20:11 INFO - mozleak == 0.1 16:20:11 INFO - mozlog == 3.5 16:20:11 INFO - moznetwork == 0.27 16:20:11 INFO - mozprocess == 0.25 16:20:11 INFO - mozprofile == 0.28 16:20:11 INFO - mozrunner == 6.13 16:20:11 INFO - mozscreenshot == 0.1 16:20:11 INFO - mozsystemmonitor == 0.3 16:20:11 INFO - moztest == 0.8 16:20:11 INFO - mozversion == 1.4 16:20:11 INFO - psutil == 3.1.1 16:20:11 INFO - requests == 1.2.3 16:20:11 INFO - wsgiref == 0.1.2 16:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:11 INFO - Using env: {'DISPLAY': ':0', 16:20:11 INFO - 'HOME': '/home/cltbld', 16:20:11 INFO - 'LANG': 'en_US.UTF-8', 16:20:11 INFO - 'LANGUAGE': 'en_US:en', 16:20:11 INFO - 'LOGNAME': 'cltbld', 16:20:11 INFO - 'MAIL': '/var/mail/cltbld', 16:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:11 INFO - 'MOZ_NO_REMOTE': '1', 16:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:11 INFO - 'NO_EM_RESTART': '1', 16:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:11 INFO - 'PWD': '/builds/slave/test', 16:20:11 INFO - 'SHELL': '/bin/bash', 16:20:11 INFO - 'SHLVL': '1', 16:20:11 INFO - 'TERM': 'linux', 16:20:11 INFO - 'TMOUT': '86400', 16:20:11 INFO - 'USER': 'cltbld', 16:20:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:11 INFO - '_': '/tools/buildbot/bin/python'} 16:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:20:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:20:12 INFO - Installing collected packages: simplejson 16:20:12 INFO - Running setup.py install for simplejson 16:20:12 INFO - building 'simplejson._speedups' extension 16:20:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:20:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:20:13 INFO - Successfully installed simplejson 16:20:13 INFO - Cleaning up... 16:20:13 INFO - Return code: 0 16:20:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:20:13 INFO - Using env: {'DISPLAY': ':0', 16:20:13 INFO - 'HOME': '/home/cltbld', 16:20:13 INFO - 'LANG': 'en_US.UTF-8', 16:20:13 INFO - 'LANGUAGE': 'en_US:en', 16:20:13 INFO - 'LOGNAME': 'cltbld', 16:20:13 INFO - 'MAIL': '/var/mail/cltbld', 16:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:13 INFO - 'MOZ_NO_REMOTE': '1', 16:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:13 INFO - 'NO_EM_RESTART': '1', 16:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:13 INFO - 'PWD': '/builds/slave/test', 16:20:13 INFO - 'SHELL': '/bin/bash', 16:20:13 INFO - 'SHLVL': '1', 16:20:13 INFO - 'TERM': 'linux', 16:20:13 INFO - 'TMOUT': '86400', 16:20:13 INFO - 'USER': 'cltbld', 16:20:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:13 INFO - '_': '/tools/buildbot/bin/python'} 16:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:20:14 INFO - Cleaning up... 16:20:14 INFO - Return code: 0 16:20:14 INFO - Running post-action listener: _resource_record_post_action 16:20:14 INFO - Running post-action listener: _start_resource_monitoring 16:20:14 INFO - Starting resource monitoring. 16:20:14 INFO - [mozharness: 2017-08-19 23:20:14.106476Z] Finished create-virtualenv step (success) 16:20:14 INFO - [mozharness: 2017-08-19 23:20:14.106992Z] Running install step. 16:20:14 INFO - Running pre-action listener: _resource_record_pre_action 16:20:14 INFO - Running main action method: install 16:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:14 INFO - Reading from file tmpfile_stdout 16:20:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:20:14 INFO - Reading from file tmpfile_stdout 16:20:14 INFO - Output received: 16:20:14 INFO - Usage: mozinstall [options] installer 16:20:14 INFO - Options: 16:20:14 INFO - -h, --help show this help message and exit 16:20:14 INFO - -d DEST, --destination=DEST 16:20:14 INFO - Directory to install application into. [default: 16:20:14 INFO - "/builds/slave/test"] 16:20:14 INFO - --app=APP Application being installed. [default: firefox] 16:20:14 INFO - mkdir: /builds/slave/test/build/application 16:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:20:32 INFO - Reading from file tmpfile_stdout 16:20:32 INFO - Output received: 16:20:32 INFO - /builds/slave/test/build/application/firefox/firefox 16:20:32 INFO - Running post-action listener: _resource_record_post_action 16:20:32 INFO - [mozharness: 2017-08-19 23:20:32.438966Z] Finished install step (success) 16:20:32 INFO - [mozharness: 2017-08-19 23:20:32.439247Z] Running setup-mitmproxy step. 16:20:32 INFO - Running pre-action listener: _resource_record_pre_action 16:20:32 INFO - Running main action method: setup_mitmproxy 16:20:32 INFO - Skipping: mitmproxy is not required 16:20:32 INFO - Running post-action listener: _resource_record_post_action 16:20:32 INFO - [mozharness: 2017-08-19 23:20:32.440394Z] Finished setup-mitmproxy step (success) 16:20:32 INFO - [mozharness: 2017-08-19 23:20:32.440612Z] Running run-tests step. 16:20:32 INFO - Running pre-action listener: _resource_record_pre_action 16:20:32 INFO - Running pre-action listener: _set_gcov_prefix 16:20:32 INFO - Running main action method: run_tests 16:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:32 INFO - Python 2.7.3 16:20:32 INFO - Return code: 0 16:20:32 INFO - grabbing minidump binary from tooltool 16:20: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')]} 16:20:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1062130>, '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 0x1063030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10634c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:20:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:20:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:20:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:32 INFO - Return code: 0 16:20:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:20:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:32 INFO - ENV: RUST_BACKTRACE is now full 16:20:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:20:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 16:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 16:20:32 INFO - Using env: {'DISPLAY': ':0', 16:20:32 INFO - 'HOME': '/home/cltbld', 16:20:32 INFO - 'LANG': 'en_US.UTF-8', 16:20:32 INFO - 'LANGUAGE': 'en_US:en', 16:20:32 INFO - 'LOGNAME': 'cltbld', 16:20:32 INFO - 'MAIL': '/var/mail/cltbld', 16:20:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:32 INFO - 'MOZ_NO_REMOTE': '1', 16:20:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:32 INFO - 'NO_EM_RESTART': '1', 16:20:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:32 INFO - 'PWD': '/builds/slave/test', 16:20:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:32 INFO - 'RUST_BACKTRACE': 'full', 16:20:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:20:32 INFO - 'SHELL': '/bin/bash', 16:20:32 INFO - 'SHLVL': '1', 16:20:32 INFO - 'STYLO_FORCE_ENABLED': '1', 16:20:32 INFO - 'TERM': 'linux', 16:20:32 INFO - 'TMOUT': '86400', 16:20:32 INFO - 'USER': 'cltbld', 16:20:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148', 16:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:32 INFO - '_': '/tools/buildbot/bin/python'} 16:20:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 16:20:32 INFO - mozversion application_buildid: 20170819222929 16:20:32 INFO - mozversion application_changeset: 5ca5691372cb432ec1fa4693ca608a30858226de 16:20:32 INFO - mozversion application_display_name: Nightly 16:20:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:32 INFO - mozversion application_name: Firefox 16:20:32 INFO - mozversion application_remotingname: firefox 16:20:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:20:32 INFO - mozversion application_vendor: Mozilla 16:20:32 INFO - mozversion application_version: 57.0a1 16:20:32 INFO - mozversion platform_buildid: 20170819222929 16:20:32 INFO - mozversion platform_changeset: 5ca5691372cb432ec1fa4693ca608a30858226de 16:20:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:20:32 INFO - mozversion platform_version: 57.0a1 16:20:32 INFO - using testdate: 1503184832 16:20:32 INFO - actual date: 1503184832 16:20:32 INFO - starting webserver on 'localhost:40425' 16:20:32 INFO - SUITE-START | Running 2 tests 16:20:32 INFO - TEST-START | dromaeo_css 16:20:32 INFO - Initialising browser for dromaeo_css test... 16:20:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40425/getInfo.html -profile /tmp/tmpiYZVde/profile 16:20:32 INFO - TEST-INFO | started process 8767 (/builds/slave/test/build/application/firefox/firefox http://localhost:40425/getInfo.html) 16:20:39 INFO - TEST-INFO | 8767: exit 0 16:20:39 INFO - Browser initialized. 16:20:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:39 INFO - TEST-INFO | started process 8951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiYZVde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:40 INFO - PID 8951 | 16:20:40 INFO - PID 8951 | (/builds/slave/test/build/application/firefox/firefox:9001): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:20:40 INFO - PID 8951 | 16:20:41 INFO - PID 8951 | 16:20:41 INFO - PID 8951 | (/builds/slave/test/build/application/firefox/firefox:9063): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:20:41 INFO - PID 8951 | 16:20:41 INFO - PID 8951 | __metrics Screen width/height:1600/1200 16:20:41 INFO - PID 8951 | colorDepth:24 16:20:41 INFO - PID 8951 | Browser inner width/height: 1024/768 16:20:41 INFO - PID 8951 | __metrics 16:20:50 INFO - PID 8951 | RSS: Main: 174702592 16:20:50 INFO - PID 8951 | 16:23:49 INFO - PID 8951 | Cycle 1(1): loaded http://localhost:40425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40425/tests/dromaeo/cssquery-ext.html) 16:23:50 INFO - PID 8951 | RSS: Main: 177971200 16:23:50 INFO - PID 8951 | 16:26:52 INFO - PID 8951 | Cycle 1(1): loaded http://localhost:40425/tests/dromaeo/cssquery-ext.html (next: http://localhost:40425/tests/dromaeo/cssquery-jquery.html) 16:26:53 INFO - PID 8951 | RSS: Main: 174559232 16:26:53 INFO - PID 8951 | 16:29:55 INFO - PID 8951 | Cycle 1(1): loaded http://localhost:40425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40425/tests/dromaeo/cssquery-mootools.html) 16:29:55 INFO - PID 8951 | RSS: Main: 175022080 16:29:55 INFO - PID 8951 | 16:32:57 INFO - PID 8951 | Cycle 1(1): loaded http://localhost:40425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40425/tests/dromaeo/cssquery-prototype.html) 16:32:58 INFO - PID 8951 | RSS: Main: 175271936 16:32:58 INFO - PID 8951 | 16:36:01 INFO - PID 8951 | Cycle 1(1): loaded http://localhost:40425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40425/tests/dromaeo/cssquery-yui.html) 16:36:02 INFO - PID 8951 | RSS: Main: 179294208 16:36:02 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | Cycle 1(1): loaded http://localhost:40425/tests/dromaeo/cssquery-yui.html (next: http://localhost:40425/tests/dromaeo/cssquery-dojo.html) 16:39:04 INFO - PID 8951 | RSS: Main: 179769344 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | __start_tp_report 16:39:04 INFO - PID 8951 | _x_x_mozilla_page_load 16:39:04 INFO - PID 8951 | _x_x_mozilla_page_load_details 16:39:04 INFO - PID 8951 | |i|pagename|runs| 16:39:04 INFO - PID 8951 | |0;dojo.html;3140.2934339773556;3170.0965224910906;3174.5238214267843;3175.7141857232846;3211.32562161946;6120.204373431453;6124.571280010401;6127.632342059468;6170.136180934667;6214.596051256665;6121.510279177666;6203.689815509229;6217.533684973622;6219.036049412348;6238.937610623892;5659.207710920475;5662.094064949609;5667.121596152592;5684.8294551163535;5699.914501282464;5695.743691533891;5723.54211663066;5734.885302293952;5742.942570574303;5758.510526605222;5634.859128521799;5679.517241034517;5716.1711551824965;5755.165501002352;5796.710164491779;5538.556915446755;5608.074667679848;5621.690807005613;5681.346645135821;5702.54379649627;5486.725663716838;5504.119340905476;5577.665340079568;5594.552435805126;5610.298712660918;5496.615236933416;6001.909971350433;6141.508679305645;6178.474829639441;6220.911340515392;6636.070950066995;6667.233268174174;6735.057092007123;6745.8650826983185;6777.085093512362;6583.045458408552;6690.297518760557;6693.866122677519;6700.329967003309;6750.257471678112;6197.938020619781;6205.410486003822;6226.190595222637;6276.905846412307;6284.5600807943;6778.694958726869;6781.38967492928;6794.8301292467095;6797.932020679828;6811.523193376515;6426.935730642727;6514.609123452608;6606.8348291293105;6609.405153536205;6635.535512514174;6545.574537655038;6571;6618.801435956929;6664.500162487833;6667.6666166691475;6651.66741662915;6656.068150458939;6661.600303981777;6699.866002679919;6703;6641.501887358468;6642.701078451481;6664.067030615718;6747.089142965735;6754.223264324567;5367.221752845893;5408.567314614821;5468.91796623051;5478.643888147258;5487.588430867621;4601.723896566216;4683.2038553446;4709.505501922317;4762.78567464465;4771.284307353855;5664.8867022659315;5700.37295897451;5858.150568167592;5861.88276234473;5862.70686465675;6613.603183808987;6667;6679.732810687616;6685.030670552743;6698.698558564876;5749.482546570829;5760.74076666551;5781.19063331134;5848.473637372657;5853.0635098384055;5837.124431335249;5956.910646340309;5964.970175149183;5968.134620480006;5973.402659734079;6428.453581445629;6432.903506447407;6539.574927629689;6548.70530826114;6549.312322206195;6545.181852268466;6648.135742353463;6648.933510664831;6652;6653.866922661423;6381.968090159519;6403.4877209824035;6419.101325814297;6422.678866056772;6505.8698826024165;6511.674416279072;6514.413702766774;6532.216134063943;6540.215174179129;6549.345065493412;6578.980258060008;6597.439217666552;6614;6655.767048153291;6704.698288577123;6369.717314662904;6370.8088757337355;6439.130717353285;6473.287938326686;6486.54594178403;6440.774572890114;6447.323031081856;6459.773907913201;6473.902891456538;6487.578307410004;6383.297837237993;6443.097966284818;6462.3537646235;6466.612003279818;6472.611643301417;6497.122888410193;6531.281559028598;6586.308437613981;6606.6036037837885;6622.867542649024;6276.184096067482;6300.9684951574945;6322.494200464043;6334.144890439732;6367.713452894538 16:39:04 INFO - PID 8951 | |1;ext.html;825.4510750351017;863.8445079885622;879.2087121590565;888.4003297774001;1205.9698507537305;31190.22024449387;43554.782226088864;44373.33439998403;44474.33288500667;44607;44785;45231;45275.32087018697;45282;45423.545764542345;7323.7070517179245;7593.316601505863;7996.120426753053;8005.5997200140055;8027.638756255953;7839.25527074927;7955.522668639871;7958.721444749435;7959.522428654271;7962.243586859239;7951.840963180733;8008.67965281388;8023;8054.23484768946;8066.71766488173;7932.365410767125;7949.0858551266765;7974.800629984239;7982.121966583672;7989.5605741684185;7779.416543759184;7863.174366691473;7865.134835168127;7873.291403773688;7878.487898286593;38881.61118388808;39155;39164;39171;39214;3623.9456408153897;3662.963370366289;3663.358912190383;3667.688246499051;3669.486271921933;31774;31832.363352732817;32121.83939080313;32186;32192;4970.179920313144;5092.694438333712;5114.2584325273;5140.7172605506685;5183.559397451221;185244;185445;185564;186283;186519;49066.75466622644;49115;49167.26249106266;49291.507084929406;49526.50473495219;51769.22346164811;51865.2220216697;51910.22134667983;52001.219981700306;52011.219831702554;13882.791758123636;16365.918170409072;16719.080450575093;16762.664746705;16772.32910683559;11484.138689598314;13707.725845483035;13814.861851381558;13836.03147779666;13946.511872084428;14514.564563063124;14515;14547.127172369692;14627.341769620392;14717.92641036788;5818.156367326714;5832.154337621021;5852.356240813507;5880.647161170344;5895.469407753323;988.7874107066872;1007.7329507680324;1021.8007488539663;1029.505837198149;1037.4397825174321;23023.42441438944;23025.53948921012;23187.536249275257;23329.650055249185;23361.649575256386;1120.7310245541012;1126.921115521922;1129.5764088466824;1131.2872890079198;1137.7155711072232;12074.517019319128;12223.205491643015;12276.693082673004;12414.875851241553;12443.813342799865;220280;221417;221636;222475;222606;52885.47114528882;53063;53192.46807531953;53287.46712532903;53381.466185338424;1473.123491522521;1486.5837565481681;1495.4765831958728;1506.0361368724025;1518.301581272627;22980.885095574416;22984.4253893654;23167.65248521307;23204.767952320937;23376.883115584315;38072.23855522929;38265.80867095758;38510.6148938507;38554.421683675326;38647.6135238644;189820;190646;190790;190837;190942;34256;37070.25859482741;37261.441078384385;37397.626023739416;37603.435948461345;47470.76264618655;47675.284870726275;47941.28088078751;48185.277220842414;48353.5164648349;34628;34866.65133348634;34912.650873491955;34989.825050874584;35858.4621230687;34462.65537344695;34641.65358346384;34680;34800.82599587087;35281;38558;38578.228435431694;38642.03394915037;38873.2225355497;39020;33211.33577328488;33449.16377090592;33709;34263.48604770881;34497.13757156091;24012.63981040321;24419.877900610383;25019.12433064834;25298.620520692573;25465.49069018572 16:39:04 INFO - PID 8951 | |2;jquery.html;572.3303734630482;574.1703238819904;585.8096118761398;591.4588151841066;599.69415598045;21967.890160549196;22305;22744.20395286165;22847.200347987822;22870.771292287092;26571.335716607093;27138.32154196141;27164.1850744478;27176.184714458548;27189.184324470247;6297.968510157454;6502.122213501164;6502.31725668805;6505.34946505348;6509.056186852904;5918.496927761145;6490;6497.5126865485045;6508.576942498746;6508.739650413978;6429.903551446732;6433.7426502939825;6442.291347951722;6443.387878151568;6456.451201647866;6426.2931077581425;6426.967865160645;6437.967810160966;6448.097266382711;6463.806085817433;5993.340732519419;5998.730057147395;6009.699515024231;6021.427964343424;6032.819015429544;28740.281492962633;29552.26119347012;30147.547786783216;30384;30558.08325750231;1845.474039898636;1891.3191251149576;1895.3650527073446;1896.7629046369204;1902.4673091534391;19785.802141978686;20053.29813456522;20438.182472701075;20923.163073477044;20936.895315523325;2475.9752402475924;2515.434027343833;2547.923562293134;2558.040734724478;2558.1685952065654;140683;144135;144244.99999999895;144319;144383;14873.851261487463;14878.70242595142;14936.25318734059;15091.320890559951;15825;23964.281071567882;23966.32235743516;23997;24059.759402406104;24069.51860962771;10545.47272636365;10642.627508037182;10650.680479585624;10734.838977415346;10828.133749300037;8664.826703466022;9073.54632268384;9885.505724713736;10016.949915250378;10030.799384012278;8927.776805579782;9330.673426430043;9353.345265831462;9475.763105922408;9602.9039709602;2729.4404647047704;2734.9589756153673;2806.4527417153868;2852.8858845646355;2866.9283267918468;934.5654270764128;974.5176137811687;988.5403287471216;989.8317286061387;1006.2503434941016;19642.803571964098;19728.802711972985;19733.60532789336;19919;20366.592668146553;1000.1898462245605;1049.4752623688155;1057.4395570347729;1066.679996001212;1073.0128281980597;11166.665000050012;11173.608923687632;11262.549498020151;11357.943210283896;11370.772584548262;482227;504767;505538;515035;517335;122774.38612806879;123408.38295808464;123701;124076.37961810314;124326;1254.1659796235401;1301.622529466463;1313.1070871807071;1322.8346456692914;1327.3827670133435;21121.89439052795;21736;21899.452513686647;22106.115755370247;22850.42873928165;59171.40828591659;59302.11046834214;61627.6918615422;62242.066369005406;63736;71880.64059679669;72019;72734;72780;72860.63569682118;12584.307863067253;13190.274534900289;13209.471621135048;14468.85531144675;14708.41166353334;24371.14700985457;24528.14151504689;24751.50496990086;24761.133360332304;24796.628050578896;18733.437996860117;19154.80845191586;19301.710474343177;19309.613807724047;19352.32266870653;16512.834871651612;17261.827381726023;17363.913180434018;17405.12974351252;17777.822221777617;19151.329703460313;19562;19581.118849651513;19653.0173491322;19664.705029424855;14710.77933830972;14998.625034374229;15064.774028389802;15098;15111.4710985115;18459.72310415318;18697;18745.34391296298;18771;18830.905845470686 16:39:04 INFO - PID 8951 | |3;mootools.html;1370.2052809370566;1399.9510017149403;1436.7356726081055;1441.3009690300205;1441.5315022617651;12446.817552332514;14211.573652790406;14760.188189649565;14874.181919994397;14879.92560037201;12579.748405031916;12695.93652031741;14151.150930944124;14809.777853332209;14828.25858707063;2706.120510833982;2740.9588856167074;2755.3800394911086;2756.710545392735;2760.9922378331967;2605.8566778827158;2644.6694163229595;2713.4573085382904;2713.8507382093976;2716.6468359113287;2773.1680495851265;2798.734120258582;2801.607774911514;2815.957760633592;2820.182147177316;2654.5089158505543;2663.8002149838744;2689.731026897314;2692.3000019994843;2708.187543736881;2532.835365701242;2533.062766776286;2541.2884392370165;2545.8727063646743;2548.923532294016;14100.717985640229;14254.786178207336;14260;14290.285485725672;14308.141511509342;7736.419768517328;8004.359651227888;8011.559364234965;8037.15609860962;8044.879326810103;5075.4163271223915;5092.363454568179;5204.115300398941;5263.921041184385;5271.973640131775;1873.962520749591;1888.3202047262973;1902.7145928110756;1930.256851112318;1937.5737337785665;23781;23861.642075368884;23892.522149557084;23893.283201503982;24005.879970600035;6494.870102597922;6562.114114594564;6636.170478690164;6747.797566073025;6809.250982391933;15326.157061361731;15698.607534811492;15798.763018554731;15845.207739612973;16266.593335166715;7459.888101678479;7654.617269136632;7663.348615367645;7669.9616501917135;7677.731279405194;6913.965430172817;7137.92862071383;7138.714451421989;7234.855302894018;7275.272472752682;5033.496650334937;5178.896422071537;5187.662801917939;5217.791288348423;5231.764570594332;1556.3385561136472;1560.9219539023231;1564.8982816116916;1573.3785154863765;1585.1044160049535;899.4198741811495;913.5295322908707;916.8853893263342;920.3741455810114;928.6239073175375;7470.0662417197855;7482.401407887356;7504.174540800507;7518.060242469692;7523.285287897641;709.1773542690454;726.8364617961022;727.2545640718306;730.5680865503566;744.140517702055;4626.676132670748;4663.114008338405;4958.975205124024;5282.947170528246;5353.929214157184;19630.705539416922;20053.799462005485;20475.38573842787;20786.48033799137;20791.480212994797;19415.514612134808;19862.801371986094;20065.498362541053;20100.396988090088;20135.993200339923;10807.621733239299;10895.128389728803;11136.777264454828;11189.776204475866;11257.943710281395;8086.757397278091;8310.70912518059;8359.95820020896;8395.538245396561;8509.404341696269;17225.31098756036;17325.30698772035;17360.39238626642;17785.822141778415;17928.820711793236;18042.729359059886;18225.726614100535;18323.450296491126;18387.816121838612;18392.724109138642;10505;10668.146548275965;10694.41180735067;10715.303505272132;10725.08836748885;13314.46742130304;13349.599512014654;13444.663883402993;13498.797518037434;13512.864871351161;10547.630832920811;10571.471426428494;10685.412302323135;10955.287906286067;11094.833577496183;10903.29128606638;10914.727131821768;10967.50646220906;11083.833742493707;11187.608433704781;9609.51952402391;9804.313698041355;9806;9807.656732014346;9813.509324533601;7018.824529386806;7206.351428371472;7336.486445948945;7343.192248852729;7362.668679909524;7250.3112204342615;7299.233580473974;7397.445191610543;7416.96291518539;7450.925490745023 16:39:04 INFO - PID 8951 | |4;prototype.html;500.9460667829283;518.1993819548796;528.941816400196;536.493014101674;543.1011675676754;6229.844253893655;6241.188645476093;6262.426440467982;6282.937170628293;6300.21247344082;6189.783357582485;6215.813525594228;6226.657533835637;6235.532335074865;6241.344658810827;5129.128048231791;5141.665791723535;5154.613403994716;5156.793728250866;5170.663906846043;4799.232122860343;5048.444671086178;5141.280220769096;5172.741362931857;5220.216967454874;4953.554180123788;4958.206686930092;4961.213962973345;4961.801527938878;5002.874928126807;4836.22620380741;4845.951540484585;4910.705357678551;4956.107900577895;4966.155753521892;4280.507741609724;4369.80335884886;4425.336199570058;4448.933266001012;4480.305552639314;5996.16053752475;6017.909731354033;6038.252595069233;6051.939480605181;6079.848003799941;5644.491995720405;5670.518005969498;5687.374388817227;5702.914456283159;5735;6544;6579.868402631969;6587.538872278942;6597.901031484532;6610.338966103399;4823.300621409911;4845.951540484585;4881.707097574157;4908.901821963576;4914.70511769295;6640.833979150511;6704.848721101074;6711.932880671179;6711.986404078805;6783.896991932467;5407.351117865803;5439.129739241703;5448.128299472065;5496.955578440084;5533.280673512498;5519.558435325164;5557.915356976917;5575.721213939287;5596.664200148004;5597.888042239132;5941.970290148608;5942.841145976493;5968.344691140917;5975.372585878507;6058.787942421994;6622;6623.337666233435;6638.83402914931;6697.497687673444;6731.764388246388;1926.1524929031182;1938.2440848068982;1952.375239923211;1964.1831306041854;1978.5943881504545;1390.5133203378737;1444.162385816245;1445.6602698365875;1449.7317996170743;1477.6896851661056;5730.541556675456;5761.0988373836535;5789.768409263666;5800.767969281266;5818.2436283282905;6604.669766511655;6682.665866706645;6728.932710672929;6765.627890465973;6787.932120678829;5743.396943320975;5758.827235182951;5803.158542011469;5823.4467725566;5831.154482599999;3559.982200089035;3566.4293713005795;3597.982010089933;3630.128769095451;3630.511490289022;6473.190851143607;6506.674666266762;6540.6729663516635;6580.440662543738;6601.768938087144;6922.965385173042;6928.688209030605;6951.617661028591;6952.478564107712;6967.1291088613925;6543.967280163569;6566.5731727438515;6568.8029359120255;6592;6604.174478190226;6782.593044417351;6815.761448349284;6819.181698196248;6829.760958366433;6831.385175334244;6721.428678562377;6731.461483081243;6749.73001079971;6757.425618822455;6776.898346524707;6496.285408605144;6508.544401892012;6560.442362399059;6571.342865713582;6587.781260466829;5477.260569823023;5482.259894914136;5504.6421982571;5528.733219380035;5529.336479622471;6567.408933196035;6611.438027767501;6702.664866756741;6760.966195168992;6837.760678376233;6380.628164944559;6441.098246245436;6468.5472016958365;6507.5921908894015;6536.901946470902;6426.518011149276;6463.15978922737;6485.156929599122;6507.186601674791;6579.703913323816;6296.968515157395;6360.173177487082;6400.743970241138;6410.1987251593555;6411.3909178627955;6452.322506136976;6492.285848556749;6550.705218265285;6566.277709452052;6597.901031484627;6323.652199128908;6343.3339499351905;6372.681365931592;6392.872142557216;6419.422251997343 16:39:04 INFO - PID 8951 | |5;yui.html;914.5564401265385;919.4621146629217;933.733885842535;937.8780758501393;952.3095755577208;19078.90460547697;19684.11421486031;19747.605047899033;19814.801851981476;21856.344309670694;21554.56890862182;21892.562148757017;22013.889930550366;22036.33890983273;22059;1041.1670663469213;1076.5048077884182;1077.6928575356026;1080.287010573022;1083.9024487796096;1016.506994107857;1051.8001579699871;1069.6897899609144;1075.9408232547207;1077.7305673581604;1115.358668765459;1117.3686866920164;1118.2172479264507;1118.2563595209176;1125.774845030993;1106.9335839849634;1107.2360071550604;1107.850440190572;1108.528875228029;1111.7832022755565;811.6550466051905;811.6672164412563;812.9065157506903;813.1746277528314;817.7873752824249;18199;18282.177302021308;18311.267549298012;18365.816341836544;18770.061496925235;21946.231881884058;22323.218687346027;22346.329610111723;22399;22498.66252006221;16993.57516062096;17187;17289.65420691592;17333.306667733275;17335.479935601954;3310.2882880180637;3322.2192784695576;3343.498475228711;3346.5649465569322;3352.379809735207;122955.3852230742;124155;127298.7270127296;127526;129072;16657.083860387796;16808.243629036722;17066.317347306216;17115;17338.219780109925;31762.205944851103;32421.837890810395;32435.35129297401;32437.35125297528;32480.02559923206;7855.607219638995;8187.836243275101;8257.669693212325;8638;9077.364584479023;4212.68404869636;4298.290782020994;4300.462442194726;4347.152305300436;4350.60844523988;5275.419703832576;5374.35507739066;5375.059364611177;5377.112776391851;5390.51485366319;1062.4103622489438;1077.9622713205001;1085.630885498934;1095.1457862866976;1095.8301463273206;687.965601719912;703.8521910398771;706.8793619142572;707.9681414336264;710.0910834132319;11707.88292117068;12413.44139513724;12798.16811907223;13030.739385212242;13433.529826456028;715.6564848872466;718.4862823081522;720.6468830273233;726.12501935168;735.9227281135511;5486.780528778884;5646.576506761927;5845.88308233833;5856.12158176277;5996.070609055603;102435.4878225604;103730.4813475943;105495;108073;109369;93337;94226;97685;100192;100287.49856250818;81103.59448202839;83407.5829620848;83587;88753.0061147237;89112;12293.692657683272;12656.810147847606;12887.742245155232;12945.482180712666;13312;38322.616773831905;39162.412563811;40762;41009.974750631474;41163.588364115974;69810;72497;72960.63519682367;73909.63045184739;74478.62760686161;19051.761635493647;19347.322843700404;19419.126139324046;19487;20313.695294570298;18709.625807483502;19187.731042062256;19499.12253948604;19764.11061502207;21758.45603859916;19194.616107677488;19449.708254375913;19730.90134549318;19976.90011549933;20058.197672093538;17963;18209.726854096934;18223.45329640113;18355.816441835945;18411.355602553846;19102.904485477484;19150.04249787533;19453.51366215856;19517;19586.60826783485;13123.540676076673;13618.319084045956;13827.86172138306;14171.574852754435;14725.779113313094;14530.27348632543;14941.178235197169;15265.847341526887;15360.692786144438;15383.61540961485 16:39:04 INFO - PID 8951 | __end_tp_report 16:39:04 INFO - PID 8951 | __start_cc_report 16:39:04 INFO - PID 8951 | _x_x_mozilla_cycle_collect,378 16:39:04 INFO - PID 8951 | __end_cc_report 16:39:04 INFO - PID 8951 | __startTimestamp1503185944285__endTimestamp 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | ------- Summary: start ------- 16:39:04 INFO - PID 8951 | Number of tests: 6 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | [#0] dojo.html Cycles:165 Average:6123.94 Median:6381.97 stddev:711.40 (11.1%) stddev-sans-first:673.98 16:39:04 INFO - PID 8951 | Values: 3140.3 3170.1 3174.5 3175.7 3211.3 6120.2 6124.6 6127.6 6170.1 6214.6 6121.5 6203.7 6217.5 6219.0 6238.9 5659.2 5662.1 5667.1 5684.8 5699.9 5695.7 5723.5 5734.9 5742.9 5758.5 5634.9 5679.5 5716.2 5755.2 5796.7 5538.6 5608.1 5621.7 5681.3 5702.5 5486.7 5504.1 5577.7 5594.6 5610.3 5496.6 6001.9 6141.5 6178.5 6220.9 6636.1 6667.2 6735.1 6745.9 6777.1 6583.0 6690.3 6693.9 6700.3 6750.3 6197.9 6205.4 6226.2 6276.9 6284.6 6778.7 6781.4 6794.8 6797.9 6811.5 6426.9 6514.6 6606.8 6609.4 6635.5 6545.6 6571.0 6618.8 6664.5 6667.7 6651.7 6656.1 6661.6 6699.9 6703.0 6641.5 6642.7 6664.1 6747.1 6754.2 5367.2 5408.6 5468.9 5478.6 5487.6 4601.7 4683.2 4709.5 4762.8 4771.3 5664.9 5700.4 5858.2 5861.9 5862.7 6613.6 6667.0 6679.7 6685.0 6698.7 5749.5 5760.7 5781.2 5848.5 5853.1 5837.1 5956.9 5965.0 5968.1 5973.4 6428.5 6432.9 6539.6 6548.7 6549.3 6545.2 6648.1 6648.9 6652.0 6653.9 6382.0 6403.5 6419.1 6422.7 6505.9 6511.7 6514.4 6532.2 6540.2 6549.3 6579.0 6597.4 6614.0 6655.8 6704.7 6369.7 6370.8 6439.1 6473.3 6486.5 6440.8 6447.3 6459.8 6473.9 6487.6 6383.3 6443.1 6462.4 6466.6 6472.6 6497.1 6531.3 6586.3 6606.6 6622.9 6276.2 6301.0 6322.5 6334.1 6367.7 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | [#1] ext.html Cycles:180 Average:37835.42 Median:3668.59 stddev:51746.77 (1410.5%) stddev-sans-first:51817.31 16:39:04 INFO - PID 8951 | Values: 825.5 863.8 879.2 888.4 1206.0 31190.2 43554.8 44373.3 44474.3 44607.0 44785.0 45231.0 45275.3 45282.0 45423.5 7323.7 7593.3 7996.1 8005.6 8027.6 7839.3 7955.5 7958.7 7959.5 7962.2 7951.8 8008.7 8023.0 8054.2 8066.7 7932.4 7949.1 7974.8 7982.1 7989.6 7779.4 7863.2 7865.1 7873.3 7878.5 38881.6 39155.0 39164.0 39171.0 39214.0 3623.9 3663.0 3663.4 3667.7 3669.5 31774.0 31832.4 32121.8 32186.0 32192.0 4970.2 5092.7 5114.3 5140.7 5183.6 185244.0 185445.0 185564.0 186283.0 186519.0 49066.8 49115.0 49167.3 49291.5 49526.5 51769.2 51865.2 51910.2 52001.2 52011.2 13882.8 16365.9 16719.1 16762.7 16772.3 11484.1 13707.7 13814.9 13836.0 13946.5 14514.6 14515.0 14547.1 14627.3 14717.9 5818.2 5832.2 5852.4 5880.6 5895.5 988.8 1007.7 1021.8 1029.5 1037.4 23023.4 23025.5 23187.5 23329.7 23361.6 1120.7 1126.9 1129.6 1131.3 1137.7 12074.5 12223.2 12276.7 12414.9 12443.8 220280.0 221417.0 221636.0 222475.0 222606.0 52885.5 53063.0 53192.5 53287.5 53381.5 1473.1 1486.6 1495.5 1506.0 1518.3 22980.9 22984.4 23167.7 23204.8 23376.9 38072.2 38265.8 38510.6 38554.4 38647.6 189820.0 190646.0 190790.0 190837.0 190942.0 34256.0 37070.3 37261.4 37397.6 37603.4 47470.8 47675.3 47941.3 48185.3 48353.5 34628.0 34866.7 34912.7 34989.8 35858.5 34462.7 34641.7 34680.0 34800.8 35281.0 38558.0 38578.2 38642.0 38873.2 39020.0 33211.3 33449.2 33709.0 34263.5 34497.1 24012.6 24419.9 25019.1 25298.6 25465.5 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | [#2] jquery.html Cycles:180 Average:36064.84 Median:22848.81 stddev:85307.21 (373.4%) stddev-sans-first:85504.90 16:39:04 INFO - PID 8951 | Values: 572.3 574.2 585.8 591.5 599.7 21967.9 22305.0 22744.2 22847.2 22870.8 26571.3 27138.3 27164.2 27176.2 27189.2 6298.0 6502.1 6502.3 6505.3 6509.1 5918.5 6490.0 6497.5 6508.6 6508.7 6429.9 6433.7 6442.3 6443.4 6456.5 6426.3 6427.0 6438.0 6448.1 6463.8 5993.3 5998.7 6009.7 6021.4 6032.8 28740.3 29552.3 30147.5 30384.0 30558.1 1845.5 1891.3 1895.4 1896.8 1902.5 19785.8 20053.3 20438.2 20923.2 20936.9 2476.0 2515.4 2547.9 2558.0 2558.2 140683.0 144135.0 144245.0 144319.0 144383.0 14873.9 14878.7 14936.3 15091.3 15825.0 23964.3 23966.3 23997.0 24059.8 24069.5 10545.5 10642.6 10650.7 10734.8 10828.1 8664.8 9073.5 9885.5 10016.9 10030.8 8927.8 9330.7 9353.3 9475.8 9602.9 2729.4 2735.0 2806.5 2852.9 2866.9 934.6 974.5 988.5 989.8 1006.3 19642.8 19728.8 19733.6 19919.0 20366.6 1000.2 1049.5 1057.4 1066.7 1073.0 11166.7 11173.6 11262.5 11357.9 11370.8 482227.0 504767.0 505538.0 515035.0 517335.0 122774.4 123408.4 123701.0 124076.4 124326.0 1254.2 1301.6 1313.1 1322.8 1327.4 21121.9 21736.0 21899.5 22106.1 22850.4 59171.4 59302.1 61627.7 62242.1 63736.0 71880.6 72019.0 72734.0 72780.0 72860.6 12584.3 13190.3 13209.5 14468.9 14708.4 24371.1 24528.1 24751.5 24761.1 24796.6 18733.4 19154.8 19301.7 19309.6 19352.3 16512.8 17261.8 17363.9 17405.1 17777.8 19151.3 19562.0 19581.1 19653.0 19664.7 14710.8 14998.6 15064.8 15098.0 15111.5 18459.7 18697.0 18745.3 18771.0 18830.9 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | [#3] mootools.html Cycles:180 Average:8885.09 Median:2625.26 stddev:6142.21 (234.0%) stddev-sans-first:6133.49 16:39:04 INFO - PID 8951 | Values: 1370.2 1400.0 1436.7 1441.3 1441.5 12446.8 14211.6 14760.2 14874.2 14879.9 12579.7 12695.9 14151.2 14809.8 14828.3 2706.1 2741.0 2755.4 2756.7 2761.0 2605.9 2644.7 2713.5 2713.9 2716.6 2773.2 2798.7 2801.6 2816.0 2820.2 2654.5 2663.8 2689.7 2692.3 2708.2 2532.8 2533.1 2541.3 2545.9 2548.9 14100.7 14254.8 14260.0 14290.3 14308.1 7736.4 8004.4 8011.6 8037.2 8044.9 5075.4 5092.4 5204.1 5263.9 5272.0 1874.0 1888.3 1902.7 1930.3 1937.6 23781.0 23861.6 23892.5 23893.3 24005.9 6494.9 6562.1 6636.2 6747.8 6809.3 15326.2 15698.6 15798.8 15845.2 16266.6 7459.9 7654.6 7663.3 7670.0 7677.7 6914.0 7137.9 7138.7 7234.9 7275.3 5033.5 5178.9 5187.7 5217.8 5231.8 1556.3 1560.9 1564.9 1573.4 1585.1 899.4 913.5 916.9 920.4 928.6 7470.1 7482.4 7504.2 7518.1 7523.3 709.2 726.8 727.3 730.6 744.1 4626.7 4663.1 4959.0 5282.9 5353.9 19630.7 20053.8 20475.4 20786.5 20791.5 19415.5 19862.8 20065.5 20100.4 20136.0 10807.6 10895.1 11136.8 11189.8 11257.9 8086.8 8310.7 8360.0 8395.5 8509.4 17225.3 17325.3 17360.4 17785.8 17928.8 18042.7 18225.7 18323.5 18387.8 18392.7 10505.0 10668.1 10694.4 10715.3 10725.1 13314.5 13349.6 13444.7 13498.8 13512.9 10547.6 10571.5 10685.4 10955.3 11094.8 10903.3 10914.7 10967.5 11083.8 11187.6 9609.5 9804.3 9806.0 9807.7 9813.5 7018.8 7206.4 7336.5 7343.2 7362.7 7250.3 7299.2 7397.4 7417.0 7450.9 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | [#4] prototype.html Cycles:180 Average:5582.25 Median:6202.80 stddev:1511.02 (24.4%) stddev-sans-first:1466.33 16:39:04 INFO - PID 8951 | Values: 500.9 518.2 528.9 536.5 543.1 6229.8 6241.2 6262.4 6282.9 6300.2 6189.8 6215.8 6226.7 6235.5 6241.3 5129.1 5141.7 5154.6 5156.8 5170.7 4799.2 5048.4 5141.3 5172.7 5220.2 4953.6 4958.2 4961.2 4961.8 5002.9 4836.2 4846.0 4910.7 4956.1 4966.2 4280.5 4369.8 4425.3 4448.9 4480.3 5996.2 6017.9 6038.3 6051.9 6079.8 5644.5 5670.5 5687.4 5702.9 5735.0 6544.0 6579.9 6587.5 6597.9 6610.3 4823.3 4846.0 4881.7 4908.9 4914.7 6640.8 6704.8 6711.9 6712.0 6783.9 5407.4 5439.1 5448.1 5497.0 5533.3 5519.6 5557.9 5575.7 5596.7 5597.9 5942.0 5942.8 5968.3 5975.4 6058.8 6622.0 6623.3 6638.8 6697.5 6731.8 1926.2 1938.2 1952.4 1964.2 1978.6 1390.5 1444.2 1445.7 1449.7 1477.7 5730.5 5761.1 5789.8 5800.8 5818.2 6604.7 6682.7 6728.9 6765.6 6787.9 5743.4 5758.8 5803.2 5823.4 5831.2 3560.0 3566.4 3598.0 3630.1 3630.5 6473.2 6506.7 6540.7 6580.4 6601.8 6923.0 6928.7 6951.6 6952.5 6967.1 6544.0 6566.6 6568.8 6592.0 6604.2 6782.6 6815.8 6819.2 6829.8 6831.4 6721.4 6731.5 6749.7 6757.4 6776.9 6496.3 6508.5 6560.4 6571.3 6587.8 5477.3 5482.3 5504.6 5528.7 5529.3 6567.4 6611.4 6702.7 6761.0 6837.8 6380.6 6441.1 6468.5 6507.6 6536.9 6426.5 6463.2 6485.2 6507.2 6579.7 6297.0 6360.2 6400.7 6410.2 6411.4 6452.3 6492.3 6550.7 6566.3 6597.9 6323.7 6343.3 6372.7 6392.9 6419.4 16:39:04 INFO - PID 8951 | 16:39:04 INFO - PID 8951 | [#5] yui.html Cycles:180 Average:23977.54 Median:19551.80 stddev:31793.52 (162.6%) stddev-sans-first:31835.54 16:39:04 INFO - PID 8951 | Values: 914.6 919.5 933.7 937.9 952.3 19078.9 19684.1 19747.6 19814.8 21856.3 21554.6 21892.6 22013.9 22036.3 22059.0 1041.2 1076.5 1077.7 1080.3 1083.9 1016.5 1051.8 1069.7 1075.9 1077.7 1115.4 1117.4 1118.2 1118.3 1125.8 1106.9 1107.2 1107.9 1108.5 1111.8 811.7 811.7 812.9 813.2 817.8 18199.0 18282.2 18311.3 18365.8 18770.1 21946.2 22323.2 22346.3 22399.0 22498.7 16993.6 17187.0 17289.7 17333.3 17335.5 3310.3 3322.2 3343.5 3346.6 3352.4 122955.4 124155.0 127298.7 127526.0 129072.0 16657.1 16808.2 17066.3 17115.0 17338.2 31762.2 32421.8 32435.4 32437.4 32480.0 7855.6 8187.8 8257.7 8638.0 9077.4 4212.7 4298.3 4300.5 4347.2 4350.6 5275.4 5374.4 5375.1 5377.1 5390.5 1062.4 1078.0 1085.6 1095.1 1095.8 688.0 703.9 706.9 708.0 710.1 11707.9 12413.4 12798.2 13030.7 13433.5 715.7 718.5 720.6 726.1 735.9 5486.8 5646.6 5845.9 5856.1 5996.1 102435.5 103730.5 105495.0 108073.0 109369.0 93337.0 94226.0 97685.0 100192.0 100287.5 81103.6 83407.6 83587.0 88753.0 89112.0 12293.7 12656.8 12887.7 12945.5 13312.0 38322.6 39162.4 40762.0 41010.0 41163.6 69810.0 72497.0 72960.6 73909.6 74478.6 19051.8 19347.3 19419.1 19487.0 20313.7 18709.6 19187.7 19499.1 19764.1 21758.5 19194.6 19449.7 19730.9 19976.9 20058.2 17963.0 18209.7 18223.5 18355.8 18411.4 19102.9 19150.0 19453.5 19517.0 19586.6 13123.5 13618.3 13827.9 14171.6 14725.8 14530.3 14941.2 15265.8 15360.7 15383.6 16:39:04 INFO - PID 8951 | -------- Summary: end -------- 16:39:04 INFO - PID 8951 | 16:39:04 INFO - TEST-INFO | 8951: exit 0 16:39:05 INFO - TEST-OK | dromaeo_css | took 1112200ms 16:39:05 INFO - TEST-START | kraken 16:39:05 INFO - Initialising browser for kraken test... 16:39:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40425/getInfo.html -profile /tmp/tmp6IXOzf/profile 16:39:05 INFO - TEST-INFO | started process 9378 (/builds/slave/test/build/application/firefox/firefox http://localhost:40425/getInfo.html) 16:39:11 INFO - TEST-INFO | 9378: exit 0 16:39:11 INFO - Browser initialized. 16:39:11 INFO - Running cycle 1/1 for kraken test... 16:39:11 INFO - TEST-INFO | started process 9563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6IXOzf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:12 INFO - PID 9563 | 16:39:12 INFO - PID 9563 | (/builds/slave/test/build/application/firefox/firefox:9612): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:39:12 INFO - PID 9563 | 16:39:12 INFO - PID 9563 | 16:39:12 INFO - PID 9563 | (/builds/slave/test/build/application/firefox/firefox:9671): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:39:12 INFO - PID 9563 | 16:39:12 INFO - PID 9563 | __metrics Screen width/height:1600/1200 16:39:12 INFO - PID 9563 | colorDepth:24 16:39:12 INFO - PID 9563 | Browser inner width/height: 1024/768 16:39:12 INFO - PID 9563 | __metrics 16:39:22 INFO - PID 9563 | RSS: Main: 174350336 16:39:22 INFO - PID 9563 | 16:39:25 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40425/tests/kraken/driver.html?testName=audio-beat-detection) 16:39:26 INFO - PID 9563 | RSS: Main: 178270208 16:39:26 INFO - PID 9563 | 16:39:28 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40425/tests/kraken/driver.html?testName=audio-dft) 16:39:29 INFO - PID 9563 | RSS: Main: 178524160 16:39:29 INFO - PID 9563 | 16:39:32 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40425/tests/kraken/driver.html?testName=audio-fft) 16:39:33 INFO - PID 9563 | RSS: Main: 173125632 16:39:33 INFO - PID 9563 | 16:39:35 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40425/tests/kraken/driver.html?testName=audio-oscillator) 16:39:35 INFO - PID 9563 | RSS: Main: 173654016 16:39:35 INFO - PID 9563 | 16:39:38 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:39:38 INFO - PID 9563 | RSS: Main: 174485504 16:39:38 INFO - PID 9563 | 16:39:41 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40425/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:42 INFO - PID 9563 | RSS: Main: 175583232 16:39:42 INFO - PID 9563 | 16:39:46 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40425/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:46 INFO - PID 9563 | RSS: Main: 174927872 16:39:46 INFO - PID 9563 | 16:39:49 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40425/tests/kraken/driver.html?testName=json-parse-financial) 16:39:50 INFO - PID 9563 | RSS: Main: 175357952 16:39:50 INFO - PID 9563 | 16:39:51 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:52 INFO - PID 9563 | RSS: Main: 175923200 16:39:52 INFO - PID 9563 | 16:39:54 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:55 INFO - PID 9563 | RSS: Main: 176087040 16:39:55 INFO - PID 9563 | 16:39:57 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:57 INFO - PID 9563 | RSS: Main: 175620096 16:39:57 INFO - PID 9563 | 16:40:00 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:40:01 INFO - PID 9563 | RSS: Main: 176209920 16:40:01 INFO - PID 9563 | 16:40:04 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:40:04 INFO - PID 9563 | RSS: Main: 176218112 16:40:04 INFO - PID 9563 | 16:40:06 INFO - PID 9563 | Cycle 1(1): loaded http://localhost:40425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40425/tests/kraken/driver.html?testName=ai-astar) 16:40:07 INFO - PID 9563 | RSS: Main: 177926144 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | __start_tp_report 16:40:07 INFO - PID 9563 | _x_x_mozilla_page_load 16:40:07 INFO - PID 9563 | _x_x_mozilla_page_load_details 16:40:07 INFO - PID 9563 | |i|pagename|runs| 16:40:07 INFO - PID 9563 | |0;ai-astar;99;108;105;109;106;116;110;103;109;108 16:40:07 INFO - PID 9563 | |1;audio-beat-detection;144;116;145;166;123;146;151;118;169;126 16:40:07 INFO - PID 9563 | |2;audio-dft;162;163;162;163;163;161;162;165;166;165 16:40:07 INFO - PID 9563 | |3;audio-fft;75;76;75;169;78;75;74;88;96;78 16:40:07 INFO - PID 9563 | |4;audio-oscillator;82;78;140;79;81;81;127;80;80;129 16:40:07 INFO - PID 9563 | |5;imaging-gaussian-blur;117;114;114;114;114;114;115;114;113;115 16:40:07 INFO - PID 9563 | |6;imaging-darkroom;150;151;153;150;155;150;149;150;150;158 16:40:07 INFO - PID 9563 | |7;imaging-desaturate;99;96;94;94;94;93;94;96;94;98 16:40:07 INFO - PID 9563 | |8;json-parse-financial;55;57;61;58;55;56;56;56;60;56 16:40:07 INFO - PID 9563 | |9;json-stringify-tinderbox;56;62;54;54;55;55;55;60;56;62 16:40:07 INFO - PID 9563 | |10;stanford-crypto-aes;78;74;76;74;75;78;76;75;77;74 16:40:07 INFO - PID 9563 | |11;stanford-crypto-ccm;127;121;130;124;121;126;128;127;127;158 16:40:07 INFO - PID 9563 | |12;stanford-crypto-pbkdf2;170;176;181;172;184;175;176;175;185;175 16:40:07 INFO - PID 9563 | |13;stanford-crypto-sha256-iterative;69;68;69;68;68;73;73;68;76;71 16:40:07 INFO - PID 9563 | __end_tp_report 16:40:07 INFO - PID 9563 | __start_cc_report 16:40:07 INFO - PID 9563 | _x_x_mozilla_cycle_collect,995 16:40:07 INFO - PID 9563 | __end_cc_report 16:40:07 INFO - PID 9563 | __startTimestamp1503186007062__endTimestamp 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | ------- Summary: start ------- 16:40:07 INFO - PID 9563 | Number of tests: 14 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:4.52 (4.1%) stddev-sans-first:3.67 16:40:07 INFO - PID 9563 | Values: 99.0 108.0 105.0 109.0 106.0 116.0 110.0 103.0 109.0 108.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:145.50 stddev:19.03 (13.1%) stddev-sans-first:20.14 16:40:07 INFO - PID 9563 | Values: 144.0 116.0 145.0 166.0 123.0 146.0 151.0 118.0 169.0 126.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.66 16:40:07 INFO - PID 9563 | Values: 162.0 163.0 162.0 163.0 163.0 161.0 162.0 165.0 166.0 165.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#3] audio-fft Cycles:10 Average:88.40 Median:77.00 stddev:29.19 (37.9%) stddev-sans-first:30.56 16:40:07 INFO - PID 9563 | Values: 75.0 76.0 75.0 169.0 78.0 75.0 74.0 88.0 96.0 78.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:80.00 stddev:25.29 (31.6%) stddev-sans-first:26.33 16:40:07 INFO - PID 9563 | Values: 82.0 78.0 140.0 79.0 81.0 81.0 127.0 80.0 80.0 129.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.60 16:40:07 INFO - PID 9563 | Values: 117.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 113.0 115.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:150.50 stddev:2.88 (1.9%) stddev-sans-first:2.99 16:40:07 INFO - PID 9563 | Values: 150.0 151.0 153.0 150.0 155.0 150.0 149.0 150.0 150.0 158.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.99 (2.1%) stddev-sans-first:1.56 16:40:07 INFO - PID 9563 | Values: 99.0 96.0 94.0 94.0 94.0 93.0 94.0 96.0 94.0 98.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:2.05 (3.6%) stddev-sans-first:2.05 16:40:07 INFO - PID 9563 | Values: 55.0 57.0 61.0 58.0 55.0 56.0 56.0 56.0 60.0 56.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:56.00 stddev:3.18 (5.7%) stddev-sans-first:3.35 16:40:07 INFO - PID 9563 | Values: 56.0 62.0 54.0 54.0 55.0 55.0 55.0 60.0 56.0 62.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:1.57 (2.1%) stddev-sans-first:1.42 16:40:07 INFO - PID 9563 | Values: 78.0 74.0 76.0 74.0 75.0 78.0 76.0 75.0 77.0 74.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.00 stddev:10.63 (8.4%) stddev-sans-first:11.25 16:40:07 INFO - PID 9563 | Values: 127.0 121.0 130.0 124.0 121.0 126.0 128.0 127.0 127.0 158.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:176.00 stddev:4.91 (2.8%) stddev-sans-first:4.53 16:40:07 INFO - PID 9563 | Values: 170.0 176.0 181.0 172.0 184.0 175.0 176.0 175.0 185.0 175.0 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.83 (4.0%) stddev-sans-first:2.96 16:40:07 INFO - PID 9563 | Values: 69.0 68.0 69.0 68.0 68.0 73.0 73.0 68.0 76.0 71.0 16:40:07 INFO - PID 9563 | -------- Summary: end -------- 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 16:40:07 INFO - PID 9563 | 16:40:07 INFO - PID 9563 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:40:07 INFO - TEST-INFO | 9563: exit 0 16:40:07 INFO - TEST-OK | kraken | took 62778ms 16:40:07 INFO - SUITE-END | took 1174s 16:40:08 INFO - Completed test suite (00:19:35) 16:40:08 INFO - javascript benchmark 16:40:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8621.675786374104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.2934339773556, 3170.0965224910906, 3174.5238214267843, 3175.7141857232846, 3211.32562161946, 6120.204373431453, 6124.571280010401, 6127.632342059468, 6170.136180934667, 6214.596051256665, 6121.510279177666, 6203.689815509229, 6217.533684973622, 6219.036049412348, 6238.937610623892, 5659.207710920475, 5662.094064949609, 5667.121596152592, 5684.8294551163535, 5699.914501282464, 5695.743691533891, 5723.54211663066, 5734.885302293952, 5742.942570574303, 5758.510526605222, 5634.859128521799, 5679.517241034517, 5716.1711551824965, 5755.165501002352, 5796.710164491779, 5538.556915446755, 5608.074667679848, 5621.690807005613, 5681.346645135821, 5702.54379649627, 5486.725663716838, 5504.119340905476, 5577.665340079568, 5594.552435805126, 5610.298712660918, 5496.615236933416, 6001.909971350433, 6141.508679305645, 6178.474829639441, 6220.911340515392, 6636.070950066995, 6667.233268174174, 6735.057092007123, 6745.8650826983185, 6777.085093512362, 6583.045458408552, 6690.297518760557, 6693.866122677519, 6700.329967003309, 6750.257471678112, 6197.938020619781, 6205.410486003822, 6226.190595222637, 6276.905846412307, 6284.5600807943, 6778.694958726869, 6781.38967492928, 6794.8301292467095, 6797.932020679828, 6811.523193376515, 6426.935730642727, 6514.609123452608, 6606.8348291293105, 6609.405153536205, 6635.535512514174, 6545.574537655038, 6571.0, 6618.801435956929, 6664.500162487833, 6667.6666166691475, 6651.66741662915, 6656.068150458939, 6661.600303981777, 6699.866002679919, 6703.0, 6641.501887358468, 6642.701078451481, 6664.067030615718, 6747.089142965735, 6754.223264324567, 5367.221752845893, 5408.567314614821, 5468.91796623051, 5478.643888147258, 5487.588430867621, 4601.723896566216, 4683.2038553446, 4709.505501922317, 4762.78567464465, 4771.284307353855, 5664.8867022659315, 5700.37295897451, 5858.150568167592, 5861.88276234473, 5862.70686465675, 6613.603183808987, 6667.0, 6679.732810687616, 6685.030670552743, 6698.698558564876, 5749.482546570829, 5760.74076666551, 5781.19063331134, 5848.473637372657, 5853.0635098384055, 5837.124431335249, 5956.910646340309, 5964.970175149183, 5968.134620480006, 5973.402659734079, 6428.453581445629, 6432.903506447407, 6539.574927629689, 6548.70530826114, 6549.312322206195, 6545.181852268466, 6648.135742353463, 6648.933510664831, 6652.0, 6653.866922661423, 6381.968090159519, 6403.4877209824035, 6419.101325814297, 6422.678866056772, 6505.8698826024165, 6511.674416279072, 6514.413702766774, 6532.216134063943, 6540.215174179129, 6549.345065493412, 6578.980258060008, 6597.439217666552, 6614.0, 6655.767048153291, 6704.698288577123, 6369.717314662904, 6370.8088757337355, 6439.130717353285, 6473.287938326686, 6486.54594178403, 6440.774572890114, 6447.323031081856, 6459.773907913201, 6473.902891456538, 6487.578307410004, 6383.297837237993, 6443.097966284818, 6462.3537646235, 6466.612003279818, 6472.611643301417, 6497.122888410193, 6531.281559028598, 6586.308437613981, 6606.6036037837885, 6622.867542649024, 6276.184096067482, 6300.9684951574945, 6322.494200464043, 6334.144890439732, 6367.713452894538], "value": 6071.71514757595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.4510750351017, 863.8445079885622, 879.2087121590565, 888.4003297774001, 1205.9698507537305, 31190.22024449387, 43554.782226088864, 44373.33439998403, 44474.33288500667, 44607.0, 44785.0, 45231.0, 45275.32087018697, 45282.0, 45423.545764542345, 7323.7070517179245, 7593.316601505863, 7996.120426753053, 8005.5997200140055, 8027.638756255953, 7839.25527074927, 7955.522668639871, 7958.721444749435, 7959.522428654271, 7962.243586859239, 7951.840963180733, 8008.67965281388, 8023.0, 8054.23484768946, 8066.71766488173, 7932.365410767125, 7949.0858551266765, 7974.800629984239, 7982.121966583672, 7989.5605741684185, 7779.416543759184, 7863.174366691473, 7865.134835168127, 7873.291403773688, 7878.487898286593, 38881.61118388808, 39155.0, 39164.0, 39171.0, 39214.0, 3623.9456408153897, 3662.963370366289, 3663.358912190383, 3667.688246499051, 3669.486271921933, 31774.0, 31832.363352732817, 32121.83939080313, 32186.0, 32192.0, 4970.179920313144, 5092.694438333712, 5114.2584325273, 5140.7172605506685, 5183.559397451221, 185244.0, 185445.0, 185564.0, 186283.0, 186519.0, 49066.75466622644, 49115.0, 49167.26249106266, 49291.507084929406, 49526.50473495219, 51769.22346164811, 51865.2220216697, 51910.22134667983, 52001.219981700306, 52011.219831702554, 13882.791758123636, 16365.918170409072, 16719.080450575093, 16762.664746705, 16772.32910683559, 11484.138689598314, 13707.725845483035, 13814.861851381558, 13836.03147779666, 13946.511872084428, 14514.564563063124, 14515.0, 14547.127172369692, 14627.341769620392, 14717.92641036788, 5818.156367326714, 5832.154337621021, 5852.356240813507, 5880.647161170344, 5895.469407753323, 988.7874107066872, 1007.7329507680324, 1021.8007488539663, 1029.505837198149, 1037.4397825174321, 23023.42441438944, 23025.53948921012, 23187.536249275257, 23329.650055249185, 23361.649575256386, 1120.7310245541012, 1126.921115521922, 1129.5764088466824, 1131.2872890079198, 1137.7155711072232, 12074.517019319128, 12223.205491643015, 12276.693082673004, 12414.875851241553, 12443.813342799865, 220280.0, 221417.0, 221636.0, 222475.0, 222606.0, 52885.47114528882, 53063.0, 53192.46807531953, 53287.46712532903, 53381.466185338424, 1473.123491522521, 1486.5837565481681, 1495.4765831958728, 1506.0361368724025, 1518.301581272627, 22980.885095574416, 22984.4253893654, 23167.65248521307, 23204.767952320937, 23376.883115584315, 38072.23855522929, 38265.80867095758, 38510.6148938507, 38554.421683675326, 38647.6135238644, 189820.0, 190646.0, 190790.0, 190837.0, 190942.0, 34256.0, 37070.25859482741, 37261.441078384385, 37397.626023739416, 37603.435948461345, 47470.76264618655, 47675.284870726275, 47941.28088078751, 48185.277220842414, 48353.5164648349, 34628.0, 34866.65133348634, 34912.650873491955, 34989.825050874584, 35858.4621230687, 34462.65537344695, 34641.65358346384, 34680.0, 34800.82599587087, 35281.0, 38558.0, 38578.228435431694, 38642.03394915037, 38873.2225355497, 39020.0, 33211.33577328488, 33449.16377090592, 33709.0, 34263.48604770881, 34497.13757156091, 24012.63981040321, 24419.877900610383, 25019.12433064834, 25298.620520692573, 25465.49069018572], "value": 17647.44643558258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3303734630482, 574.1703238819904, 585.8096118761398, 591.4588151841066, 599.69415598045, 21967.890160549196, 22305.0, 22744.20395286165, 22847.200347987822, 22870.771292287092, 26571.335716607093, 27138.32154196141, 27164.1850744478, 27176.184714458548, 27189.184324470247, 6297.968510157454, 6502.122213501164, 6502.31725668805, 6505.34946505348, 6509.056186852904, 5918.496927761145, 6490.0, 6497.5126865485045, 6508.576942498746, 6508.739650413978, 6429.903551446732, 6433.7426502939825, 6442.291347951722, 6443.387878151568, 6456.451201647866, 6426.2931077581425, 6426.967865160645, 6437.967810160966, 6448.097266382711, 6463.806085817433, 5993.340732519419, 5998.730057147395, 6009.699515024231, 6021.427964343424, 6032.819015429544, 28740.281492962633, 29552.26119347012, 30147.547786783216, 30384.0, 30558.08325750231, 1845.474039898636, 1891.3191251149576, 1895.3650527073446, 1896.7629046369204, 1902.4673091534391, 19785.802141978686, 20053.29813456522, 20438.182472701075, 20923.163073477044, 20936.895315523325, 2475.9752402475924, 2515.434027343833, 2547.923562293134, 2558.040734724478, 2558.1685952065654, 140683.0, 144135.0, 144244.99999999895, 144319.0, 144383.0, 14873.851261487463, 14878.70242595142, 14936.25318734059, 15091.320890559951, 15825.0, 23964.281071567882, 23966.32235743516, 23997.0, 24059.759402406104, 24069.51860962771, 10545.47272636365, 10642.627508037182, 10650.680479585624, 10734.838977415346, 10828.133749300037, 8664.826703466022, 9073.54632268384, 9885.505724713736, 10016.949915250378, 10030.799384012278, 8927.776805579782, 9330.673426430043, 9353.345265831462, 9475.763105922408, 9602.9039709602, 2729.4404647047704, 2734.9589756153673, 2806.4527417153868, 2852.8858845646355, 2866.9283267918468, 934.5654270764128, 974.5176137811687, 988.5403287471216, 989.8317286061387, 1006.2503434941016, 19642.803571964098, 19728.802711972985, 19733.60532789336, 19919.0, 20366.592668146553, 1000.1898462245605, 1049.4752623688155, 1057.4395570347729, 1066.679996001212, 1073.0128281980597, 11166.665000050012, 11173.608923687632, 11262.549498020151, 11357.943210283896, 11370.772584548262, 482227.0, 504767.0, 505538.0, 515035.0, 517335.0, 122774.38612806879, 123408.38295808464, 123701.0, 124076.37961810314, 124326.0, 1254.1659796235401, 1301.622529466463, 1313.1070871807071, 1322.8346456692914, 1327.3827670133435, 21121.89439052795, 21736.0, 21899.452513686647, 22106.115755370247, 22850.42873928165, 59171.40828591659, 59302.11046834214, 61627.6918615422, 62242.066369005406, 63736.0, 71880.64059679669, 72019.0, 72734.0, 72780.0, 72860.63569682118, 12584.307863067253, 13190.274534900289, 13209.471621135048, 14468.85531144675, 14708.41166353334, 24371.14700985457, 24528.14151504689, 24751.50496990086, 24761.133360332304, 24796.628050578896, 18733.437996860117, 19154.80845191586, 19301.710474343177, 19309.613807724047, 19352.32266870653, 16512.834871651612, 17261.827381726023, 17363.913180434018, 17405.12974351252, 17777.822221777617, 19151.329703460313, 19562.0, 19581.118849651513, 19653.0173491322, 19664.705029424855, 14710.77933830972, 14998.625034374229, 15064.774028389802, 15098.0, 15111.4710985115, 18459.72310415318, 18697.0, 18745.34391296298, 18771.0, 18830.905845470686], "value": 12285.583437143761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.2052809370566, 1399.9510017149403, 1436.7356726081055, 1441.3009690300205, 1441.5315022617651, 12446.817552332514, 14211.573652790406, 14760.188189649565, 14874.181919994397, 14879.92560037201, 12579.748405031916, 12695.93652031741, 14151.150930944124, 14809.777853332209, 14828.25858707063, 2706.120510833982, 2740.9588856167074, 2755.3800394911086, 2756.710545392735, 2760.9922378331967, 2605.8566778827158, 2644.6694163229595, 2713.4573085382904, 2713.8507382093976, 2716.6468359113287, 2773.1680495851265, 2798.734120258582, 2801.607774911514, 2815.957760633592, 2820.182147177316, 2654.5089158505543, 2663.8002149838744, 2689.731026897314, 2692.3000019994843, 2708.187543736881, 2532.835365701242, 2533.062766776286, 2541.2884392370165, 2545.8727063646743, 2548.923532294016, 14100.717985640229, 14254.786178207336, 14260.0, 14290.285485725672, 14308.141511509342, 7736.419768517328, 8004.359651227888, 8011.559364234965, 8037.15609860962, 8044.879326810103, 5075.4163271223915, 5092.363454568179, 5204.115300398941, 5263.921041184385, 5271.973640131775, 1873.962520749591, 1888.3202047262973, 1902.7145928110756, 1930.256851112318, 1937.5737337785665, 23781.0, 23861.642075368884, 23892.522149557084, 23893.283201503982, 24005.879970600035, 6494.870102597922, 6562.114114594564, 6636.170478690164, 6747.797566073025, 6809.250982391933, 15326.157061361731, 15698.607534811492, 15798.763018554731, 15845.207739612973, 16266.593335166715, 7459.888101678479, 7654.617269136632, 7663.348615367645, 7669.9616501917135, 7677.731279405194, 6913.965430172817, 7137.92862071383, 7138.714451421989, 7234.855302894018, 7275.272472752682, 5033.496650334937, 5178.896422071537, 5187.662801917939, 5217.791288348423, 5231.764570594332, 1556.3385561136472, 1560.9219539023231, 1564.8982816116916, 1573.3785154863765, 1585.1044160049535, 899.4198741811495, 913.5295322908707, 916.8853893263342, 920.3741455810114, 928.6239073175375, 7470.0662417197855, 7482.401407887356, 7504.174540800507, 7518.060242469692, 7523.285287897641, 709.1773542690454, 726.8364617961022, 727.2545640718306, 730.5680865503566, 744.140517702055, 4626.676132670748, 4663.114008338405, 4958.975205124024, 5282.947170528246, 5353.929214157184, 19630.705539416922, 20053.799462005485, 20475.38573842787, 20786.48033799137, 20791.480212994797, 19415.514612134808, 19862.801371986094, 20065.498362541053, 20100.396988090088, 20135.993200339923, 10807.621733239299, 10895.128389728803, 11136.777264454828, 11189.776204475866, 11257.943710281395, 8086.757397278091, 8310.70912518059, 8359.95820020896, 8395.538245396561, 8509.404341696269, 17225.31098756036, 17325.30698772035, 17360.39238626642, 17785.822141778415, 17928.820711793236, 18042.729359059886, 18225.726614100535, 18323.450296491126, 18387.816121838612, 18392.724109138642, 10505.0, 10668.146548275965, 10694.41180735067, 10715.303505272132, 10725.08836748885, 13314.46742130304, 13349.599512014654, 13444.663883402993, 13498.797518037434, 13512.864871351161, 10547.630832920811, 10571.471426428494, 10685.412302323135, 10955.287906286067, 11094.833577496183, 10903.29128606638, 10914.727131821768, 10967.50646220906, 11083.833742493707, 11187.608433704781, 9609.51952402391, 9804.313698041355, 9806.0, 9807.656732014346, 9813.509324533601, 7018.824529386806, 7206.351428371472, 7336.486445948945, 7343.192248852729, 7362.668679909524, 7250.3112204342615, 7299.233580473974, 7397.445191610543, 7416.96291518539, 7450.925490745023], "value": 6435.149792039213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.9460667829283, 518.1993819548796, 528.941816400196, 536.493014101674, 543.1011675676754, 6229.844253893655, 6241.188645476093, 6262.426440467982, 6282.937170628293, 6300.21247344082, 6189.783357582485, 6215.813525594228, 6226.657533835637, 6235.532335074865, 6241.344658810827, 5129.128048231791, 5141.665791723535, 5154.613403994716, 5156.793728250866, 5170.663906846043, 4799.232122860343, 5048.444671086178, 5141.280220769096, 5172.741362931857, 5220.216967454874, 4953.554180123788, 4958.206686930092, 4961.213962973345, 4961.801527938878, 5002.874928126807, 4836.22620380741, 4845.951540484585, 4910.705357678551, 4956.107900577895, 4966.155753521892, 4280.507741609724, 4369.80335884886, 4425.336199570058, 4448.933266001012, 4480.305552639314, 5996.16053752475, 6017.909731354033, 6038.252595069233, 6051.939480605181, 6079.848003799941, 5644.491995720405, 5670.518005969498, 5687.374388817227, 5702.914456283159, 5735.0, 6544.0, 6579.868402631969, 6587.538872278942, 6597.901031484532, 6610.338966103399, 4823.300621409911, 4845.951540484585, 4881.707097574157, 4908.901821963576, 4914.70511769295, 6640.833979150511, 6704.848721101074, 6711.932880671179, 6711.986404078805, 6783.896991932467, 5407.351117865803, 5439.129739241703, 5448.128299472065, 5496.955578440084, 5533.280673512498, 5519.558435325164, 5557.915356976917, 5575.721213939287, 5596.664200148004, 5597.888042239132, 5941.970290148608, 5942.841145976493, 5968.344691140917, 5975.372585878507, 6058.787942421994, 6622.0, 6623.337666233435, 6638.83402914931, 6697.497687673444, 6731.764388246388, 1926.1524929031182, 1938.2440848068982, 1952.375239923211, 1964.1831306041854, 1978.5943881504545, 1390.5133203378737, 1444.162385816245, 1445.6602698365875, 1449.7317996170743, 1477.6896851661056, 5730.541556675456, 5761.0988373836535, 5789.768409263666, 5800.767969281266, 5818.2436283282905, 6604.669766511655, 6682.665866706645, 6728.932710672929, 6765.627890465973, 6787.932120678829, 5743.396943320975, 5758.827235182951, 5803.158542011469, 5823.4467725566, 5831.154482599999, 3559.982200089035, 3566.4293713005795, 3597.982010089933, 3630.128769095451, 3630.511490289022, 6473.190851143607, 6506.674666266762, 6540.6729663516635, 6580.440662543738, 6601.768938087144, 6922.965385173042, 6928.688209030605, 6951.617661028591, 6952.478564107712, 6967.1291088613925, 6543.967280163569, 6566.5731727438515, 6568.8029359120255, 6592.0, 6604.174478190226, 6782.593044417351, 6815.761448349284, 6819.181698196248, 6829.760958366433, 6831.385175334244, 6721.428678562377, 6731.461483081243, 6749.73001079971, 6757.425618822455, 6776.898346524707, 6496.285408605144, 6508.544401892012, 6560.442362399059, 6571.342865713582, 6587.781260466829, 5477.260569823023, 5482.259894914136, 5504.6421982571, 5528.733219380035, 5529.336479622471, 6567.408933196035, 6611.438027767501, 6702.664866756741, 6760.966195168992, 6837.760678376233, 6380.628164944559, 6441.098246245436, 6468.5472016958365, 6507.5921908894015, 6536.901946470902, 6426.518011149276, 6463.15978922737, 6485.156929599122, 6507.186601674791, 6579.703913323816, 6296.968515157395, 6360.173177487082, 6400.743970241138, 6410.1987251593555, 6411.3909178627955, 6452.322506136976, 6492.285848556749, 6550.705218265285, 6566.277709452052, 6597.901031484627, 6323.652199128908, 6343.3339499351905, 6372.681365931592, 6392.872142557216, 6419.422251997343], "value": 5153.700340526119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.5564401265385, 919.4621146629217, 933.733885842535, 937.8780758501393, 952.3095755577208, 19078.90460547697, 19684.11421486031, 19747.605047899033, 19814.801851981476, 21856.344309670694, 21554.56890862182, 21892.562148757017, 22013.889930550366, 22036.33890983273, 22059.0, 1041.1670663469213, 1076.5048077884182, 1077.6928575356026, 1080.287010573022, 1083.9024487796096, 1016.506994107857, 1051.8001579699871, 1069.6897899609144, 1075.9408232547207, 1077.7305673581604, 1115.358668765459, 1117.3686866920164, 1118.2172479264507, 1118.2563595209176, 1125.774845030993, 1106.9335839849634, 1107.2360071550604, 1107.850440190572, 1108.528875228029, 1111.7832022755565, 811.6550466051905, 811.6672164412563, 812.9065157506903, 813.1746277528314, 817.7873752824249, 18199.0, 18282.177302021308, 18311.267549298012, 18365.816341836544, 18770.061496925235, 21946.231881884058, 22323.218687346027, 22346.329610111723, 22399.0, 22498.66252006221, 16993.57516062096, 17187.0, 17289.65420691592, 17333.306667733275, 17335.479935601954, 3310.2882880180637, 3322.2192784695576, 3343.498475228711, 3346.5649465569322, 3352.379809735207, 122955.3852230742, 124155.0, 127298.7270127296, 127526.0, 129072.0, 16657.083860387796, 16808.243629036722, 17066.317347306216, 17115.0, 17338.219780109925, 31762.205944851103, 32421.837890810395, 32435.35129297401, 32437.35125297528, 32480.02559923206, 7855.607219638995, 8187.836243275101, 8257.669693212325, 8638.0, 9077.364584479023, 4212.68404869636, 4298.290782020994, 4300.462442194726, 4347.152305300436, 4350.60844523988, 5275.419703832576, 5374.35507739066, 5375.059364611177, 5377.112776391851, 5390.51485366319, 1062.4103622489438, 1077.9622713205001, 1085.630885498934, 1095.1457862866976, 1095.8301463273206, 687.965601719912, 703.8521910398771, 706.8793619142572, 707.9681414336264, 710.0910834132319, 11707.88292117068, 12413.44139513724, 12798.16811907223, 13030.739385212242, 13433.529826456028, 715.6564848872466, 718.4862823081522, 720.6468830273233, 726.12501935168, 735.9227281135511, 5486.780528778884, 5646.576506761927, 5845.88308233833, 5856.12158176277, 5996.070609055603, 102435.4878225604, 103730.4813475943, 105495.0, 108073.0, 109369.0, 93337.0, 94226.0, 97685.0, 100192.0, 100287.49856250818, 81103.59448202839, 83407.5829620848, 83587.0, 88753.0061147237, 89112.0, 12293.692657683272, 12656.810147847606, 12887.742245155232, 12945.482180712666, 13312.0, 38322.616773831905, 39162.412563811, 40762.0, 41009.974750631474, 41163.588364115974, 69810.0, 72497.0, 72960.63519682367, 73909.63045184739, 74478.62760686161, 19051.761635493647, 19347.322843700404, 19419.126139324046, 19487.0, 20313.695294570298, 18709.625807483502, 19187.731042062256, 19499.12253948604, 19764.11061502207, 21758.45603859916, 19194.616107677488, 19449.708254375913, 19730.90134549318, 19976.90011549933, 20058.197672093538, 17963.0, 18209.726854096934, 18223.45329640113, 18355.816441835945, 18411.355602553846, 19102.904485477484, 19150.04249787533, 19453.51366215856, 19517.0, 19586.60826783485, 13123.540676076673, 13618.319084045956, 13827.86172138306, 14171.574852754435, 14725.779113313094, 14530.27348632543, 14941.178235197169, 15265.847341526887, 15360.692786144438, 15383.61540961485], "value": 9407.107024286202, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 105.0, 109.0, 106.0, 116.0, 110.0, 103.0, 109.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 145.0, 166.0, 123.0, 146.0, 151.0, 118.0, 169.0, 126.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 161.0, 162.0, 165.0, 166.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 169.0, 78.0, 75.0, 74.0, 88.0, 96.0, 78.0], "value": 88.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 140.0, 79.0, 81.0, 81.0, 127.0, 80.0, 80.0, 129.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 153.0, 150.0, 155.0, 150.0, 149.0, 150.0, 150.0, 158.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 94.0, 94.0, 94.0, 93.0, 94.0, 96.0, 94.0, 98.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 61.0, 58.0, 55.0, 56.0, 56.0, 56.0, 60.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 62.0, 54.0, 54.0, 55.0, 55.0, 55.0, 60.0, 56.0, 62.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 74.0, 75.0, 78.0, 76.0, 75.0, 77.0, 74.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 130.0, 124.0, 121.0, 126.0, 128.0, 127.0, 127.0, 158.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 176.0, 181.0, 172.0, 184.0, 175.0, 176.0, 175.0, 185.0, 175.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 73.0, 73.0, 68.0, 76.0, 71.0], "value": 70.3, "unit": "score"}]}]} 16:40:08 INFO - Return code: 0 16:40:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:40:08 INFO - # TBPL SUCCESS # 16:40:08 INFO - Running post-action listener: _package_coverage_data 16:40:08 INFO - Running post-action listener: _resource_record_post_action 16:40:08 INFO - [mozharness: 2017-08-19 23:40:08.321807Z] Finished run-tests step (success) 16:40:08 INFO - Running post-run listener: _resource_record_post_run 16:40:08 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 434458624; Read time: 224; Write time: 285520 16:40:08 INFO - TinderboxPrint: CPU usage
13.2% 16:40:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 224 16:40:08 INFO - TinderboxPrint: I/O write bytes / time
434,458,624 / 285,520 16:40:08 INFO - TinderboxPrint: CPU idle
8,264.2 (86.8%) 16:40:08 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 16:40:08 INFO - TinderboxPrint: Swap in / out
0 / 0 16:40:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106827776; Read time: 0; Write time: 101508 16:40:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:40:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326606848; Read time: 220; Write time: 183972 16:40:08 INFO - Running post-run listener: _upload_blobber_files 16:40:08 INFO - Blob upload gear active. 16:40:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:40:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:40:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:10 INFO - (blobuploader) - INFO - Done attempting. 16:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:10 INFO - (blobuploader) - INFO - Done attempting. 16:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:17 INFO - (blobuploader) - INFO - Done attempting. 16:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:18 INFO - (blobuploader) - INFO - Done attempting. 16:40:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:40:18 INFO - Return code: 0 16:40:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:40:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:40:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e56b6504417a21eefe6c4d17fe7b3c2e5ea89fb8fc2c9b4b2a07e3bec33ad8444d45cbfbe63d5b4bd81c30a1d397959dedb9bb651f6da91710ae5a54339437d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff6c857311514c7292d64b4348b4c7455439370b6d2f36c86a7bc1e0f99240ca96ea52a8a1720e47017fa735dc54ba87e3356e6342546286de18e6e5ad12dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3238d7f28eeb32efb32b29943b6032b5b67931f9b17196b37cceb5d84a74b3b3079f32a0e8b9be5b8e7620f9ef724a0be5d4f564e7d4fb4d002ad2b6fe68f5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98cfa31e2dd53b6fa83090a21d3b2383931c26cf1603baaa0390d90b77196cb6733fb6e88d6231b93a8425d98debce2edf446510245dc827bd900b6fcc78bf0d"} 16:40:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:40:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:40:18 INFO - Contents: 16:40:18 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e56b6504417a21eefe6c4d17fe7b3c2e5ea89fb8fc2c9b4b2a07e3bec33ad8444d45cbfbe63d5b4bd81c30a1d397959dedb9bb651f6da91710ae5a54339437d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff6c857311514c7292d64b4348b4c7455439370b6d2f36c86a7bc1e0f99240ca96ea52a8a1720e47017fa735dc54ba87e3356e6342546286de18e6e5ad12dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3238d7f28eeb32efb32b29943b6032b5b67931f9b17196b37cceb5d84a74b3b3079f32a0e8b9be5b8e7620f9ef724a0be5d4f564e7d4fb4d002ad2b6fe68f5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98cfa31e2dd53b6fa83090a21d3b2383931c26cf1603baaa0390d90b77196cb6733fb6e88d6231b93a8425d98debce2edf446510245dc827bd900b6fcc78bf0d"} 16:40:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:40:18 INFO - Copying logs to upload dir... 16:40:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:40:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.747585 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-19 16:40:17.288971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 16:40:17.292428) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e56b6504417a21eefe6c4d17fe7b3c2e5ea89fb8fc2c9b4b2a07e3bec33ad8444d45cbfbe63d5b4bd81c30a1d397959dedb9bb651f6da91710ae5a54339437d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff6c857311514c7292d64b4348b4c7455439370b6d2f36c86a7bc1e0f99240ca96ea52a8a1720e47017fa735dc54ba87e3356e6342546286de18e6e5ad12dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3238d7f28eeb32efb32b29943b6032b5b67931f9b17196b37cceb5d84a74b3b3079f32a0e8b9be5b8e7620f9ef724a0be5d4f564e7d4fb4d002ad2b6fe68f5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98cfa31e2dd53b6fa83090a21d3b2383931c26cf1603baaa0390d90b77196cb6733fb6e88d6231b93a8425d98debce2edf446510245dc827bd900b6fcc78bf0d"} build_url:https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/W9C2vB0BSYGWfd0EmSMW5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e56b6504417a21eefe6c4d17fe7b3c2e5ea89fb8fc2c9b4b2a07e3bec33ad8444d45cbfbe63d5b4bd81c30a1d397959dedb9bb651f6da91710ae5a54339437d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff6c857311514c7292d64b4348b4c7455439370b6d2f36c86a7bc1e0f99240ca96ea52a8a1720e47017fa735dc54ba87e3356e6342546286de18e6e5ad12dbc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3238d7f28eeb32efb32b29943b6032b5b67931f9b17196b37cceb5d84a74b3b3079f32a0e8b9be5b8e7620f9ef724a0be5d4f564e7d4fb4d002ad2b6fe68f5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98cfa31e2dd53b6fa83090a21d3b2383931c26cf1603baaa0390d90b77196cb6733fb6e88d6231b93a8425d98debce2edf446510245dc827bd900b6fcc78bf0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 16:40:17.319710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:40:17.320072) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1503173133.197888-280014148 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 16:40:17.404136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 16:40:17.404520) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 16:40:17.404967) ========= ========= Total master_lag: 0.19 =========