builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1501495170.54 results: success (0) revision: 26516ba270816a6cc90f5c42a9b66701369a551f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.540102) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.540640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.541039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.601916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.602250) ========= 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=a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 02:59:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2017-07-31 02:59:31 (25.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179134 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.812625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.813658) ========= 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=a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.050731 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:30.882270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 02:59:30.882625) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 26516ba270816a6cc90f5c42a9b66701369a551f --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 26516ba270816a6cc90f5c42a9b66701369a551f --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=a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 02:59:31,152 truncating revision to first 12 chars 2017-07-31 02:59:31,152 Setting DEBUG logging. 2017-07-31 02:59:31,152 attempt 1/10 2017-07-31 02:59:31,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/26516ba27081?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 02:59:32,570 unpacking tar archive at: mozilla-central-26516ba27081/testing/mozharness/ program finished with exit code 0 elapsedTime=1.819529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 02:59:32.722056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:32.722398) ========= script_repo_revision: 26516ba270816a6cc90f5c42a9b66701369a551f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:32.722794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:32.723074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:32.732371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-07-31 02:59:32.732756) ========= /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=a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:33 INFO - MultiFileLogger online at 20170731 02:59:33 in /builds/slave/test 02:59:33 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 02:59:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:33 INFO - {'append_to_log': False, 02:59:33 INFO - 'base_work_dir': '/builds/slave/test', 02:59:33 INFO - 'blob_upload_branch': 'Firefox', 02:59:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:33 INFO - 'branch': 'Firefox', 02:59:33 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:33 INFO - 'code_coverage': False, 02:59:33 INFO - 'config_files': ('talos/linux_config.py',), 02:59:33 INFO - 'default_actions': ('clobber', 02:59:33 INFO - 'read-buildbot-config', 02:59:33 INFO - 'download-and-extract', 02:59:33 INFO - 'populate-webroot', 02:59:33 INFO - 'create-virtualenv', 02:59:33 INFO - 'install', 02:59:33 INFO - 'setup-mitmproxy', 02:59:33 INFO - 'run-tests'), 02:59:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:33 INFO - 'disable_ccov_upload': False, 02:59:33 INFO - 'download_minidump_stackwalk': True, 02:59:33 INFO - 'download_symbols': 'ondemand', 02:59:33 INFO - 'enable_stylo': False, 02:59:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:33 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:33 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:33 INFO - 'gecko_profile': False, 02:59:33 INFO - 'gecko_profile_interval': 0, 02:59:33 INFO - 'installer_path': 'installer.exe', 02:59:33 INFO - 'log_level': 'info', 02:59:33 INFO - 'log_name': 'talos', 02:59:33 INFO - 'log_to_console': True, 02:59:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:33 INFO - 'opt_config_files': (), 02:59:33 INFO - 'pip_index': False, 02:59:33 INFO - 'suite': 'dromaeojs-e10s', 02:59:33 INFO - 'system_bits': '32', 02:59:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:33 INFO - 'title': 'talos-linux64-ix-002', 02:59:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:33 INFO - 'use_talos_json': True, 02:59:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:33 INFO - 'work_dir': 'build'} 02:59:33 INFO - [mozharness: 2017-07-31 09:59:33.236970Z] Running clobber step. 02:59:33 INFO - Running pre-action listener: _resource_record_pre_action 02:59:33 INFO - Running main action method: clobber 02:59:33 INFO - rmtree: /builds/slave/test/build 02:59:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:35 INFO - Running post-action listener: _resource_record_post_action 02:59:35 INFO - [mozharness: 2017-07-31 09:59:35.334761Z] Finished clobber step (success) 02:59:35 INFO - [mozharness: 2017-07-31 09:59:35.334895Z] Running read-buildbot-config step. 02:59:35 INFO - Running pre-action listener: _resource_record_pre_action 02:59:35 INFO - Running main action method: read_buildbot_config 02:59:35 INFO - Using buildbot properties: 02:59:35 INFO - { 02:59:35 INFO - "project": "", 02:59:35 INFO - "product": "firefox", 02:59:35 INFO - "who": "archaeopteryx@coole-files.de", 02:59:35 INFO - "installer_path": "public/build/target.tar.bz2", 02:59:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:59:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:59:35 INFO - "stage_platform": "linux64-stylosequential", 02:59:35 INFO - "basedir": "/builds/slave/test", 02:59:35 INFO - "buildnumber": 129, 02:59:35 INFO - "platform": "ubuntu64_hw_styloseq", 02:59:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:59:35 INFO - "slavebuilddir": "test", 02:59:35 INFO - "taskId": "Tr85kA6MRrSJk7kPD2VyBQ", 02:59:35 INFO - "branch": "mozilla-central", 02:59:35 INFO - "script_repo_revision": "production", 02:59:35 INFO - "revision": "26516ba270816a6cc90f5c42a9b66701369a551f", 02:59:35 INFO - "slavename": "talos-linux64-ix-002", 02:59:35 INFO - "repo_path": "mozilla-central" 02:59:35 INFO - } 02:59:35 INFO - Finding installer, test and symbols from parent task. 02:59:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tr85kA6MRrSJk7kPD2VyBQ'}, attempt #1 02:59:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tr85kA6MRrSJk7kPD2VyBQ'}, attempt #1 02:59:36 INFO - Task dependencies: L9gn2xeTReiDdJK-FxgWPg 02:59:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg'}, attempt #1 02:59:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 02:59:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.test_packages.json 02:59:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.crashreporter-symbols.zip 02:59:36 INFO - Running post-action listener: _resource_record_post_action 02:59:36 INFO - [mozharness: 2017-07-31 09:59:36.772444Z] Finished read-buildbot-config step (success) 02:59:36 INFO - [mozharness: 2017-07-31 09:59:36.772669Z] Running download-and-extract step. 02:59:36 INFO - Running pre-action listener: _resource_record_pre_action 02:59:36 INFO - Running main action method: download_and_extract 02:59:36 INFO - mkdir: /builds/slave/test/build/tests 02:59:36 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')]} 02:59:36 INFO - trying https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.test_packages.json 02:59:36 INFO - Downloading https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:59:37 INFO - Downloaded 989 bytes. 02:59:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:37 INFO - Using the following test package requirements: 02:59:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:37 INFO - u'common': [u'target.common.tests.zip'], 02:59:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:37 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:37 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:37 INFO - u'target.web-platform.tests.tar.gz'], 02:59:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:59:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip 02:59:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:37 INFO - Fetch https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip into memory 02:59:38 INFO - Content-Length response header: 72389766 02:59:38 INFO - Bytes received: 72389766 02:59:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip 02:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:50 INFO - Fetch https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip into memory 02:59:51 INFO - Content-Length response header: 72389766 02:59:51 INFO - Bytes received: 72389766 03:00:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.talos.tests.zip 03:00:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:00:04 INFO - Fetch https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.talos.tests.zip into memory 03:00:04 INFO - Content-Length response header: 14496686 03:00:04 INFO - Bytes received: 14496686 03:00: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')]} 03:00:05 INFO - trying https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 03:00:05 INFO - Downloading https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:00:06 INFO - Downloaded 62292573 bytes. 03:00:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 03:00:06 INFO - mkdir: /builds/slave/test/properties 03:00:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:06 INFO - Contents: 03:00:06 INFO - build_url:https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 03:00:06 INFO - Running post-action listener: _resource_record_post_action 03:00:06 INFO - Running post-action listener: set_extra_try_arguments 03:00:06 INFO - [mozharness: 2017-07-31 10:00:06.835176Z] Finished download-and-extract step (success) 03:00:06 INFO - [mozharness: 2017-07-31 10:00:06.835327Z] Running populate-webroot step. 03:00:06 INFO - Running pre-action listener: _resource_record_pre_action 03:00:06 INFO - Running main action method: populate_webroot 03:00:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:06 INFO - 'tests': ['damp', 'tps']}, 03:00:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:00:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:00:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:00:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:06 INFO - 'ts_paint', 03:00:06 INFO - 'tpaint', 03:00:06 INFO - 'sessionrestore', 03:00:06 INFO - 'sessionrestore_many_windows', 03:00:06 INFO - 'sessionrestore_no_auto_restore', 03:00:06 INFO - 'tabpaint']}, 03:00:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:00:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:00:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:06 INFO - 'talos_options': ['--mitmproxy', 03:00:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:06 INFO - '--firstNonBlankPaint'], 03:00:06 INFO - 'tests': ['quantum_pageload_google', 03:00:06 INFO - 'quantum_pageload_youtube', 03:00:06 INFO - 'quantum_pageload_amazon', 03:00:06 INFO - 'quantum_pageload_facebook']}, 03:00:06 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:06 INFO - 'talos_options': ['--stylo', 03:00:06 INFO - '--mitmproxy', 03:00:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:06 INFO - '--firstNonBlankPaint'], 03:00:06 INFO - 'tests': ['quantum_pageload_google', 03:00:06 INFO - 'quantum_pageload_youtube', 03:00:06 INFO - 'quantum_pageload_amazon', 03:00:06 INFO - 'quantum_pageload_facebook']}, 03:00:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:06 INFO - 'tsvgr_opacity', 03:00:06 INFO - 'tart', 03:00:06 INFO - 'tscrollx', 03:00:06 INFO - 'cart', 03:00:06 INFO - 'tsvg_static']}, 03:00:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:00:06 INFO - 'talos_options': ['--stylo', 03:00:06 INFO - '--stylo-threads=1', 03:00:06 INFO - '--mitmproxy', 03:00:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:00:06 INFO - '--firstNonBlankPaint'], 03:00:06 INFO - 'tests': ['tp6_google', 03:00:06 INFO - 'tp6_youtube', 03:00:06 INFO - 'tp6_amazon', 03:00:06 INFO - 'tp6_facebook']}, 03:00:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:06 INFO - 'talos_options': ['--xperf_path', 03:00:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:06 INFO - 'tests': ['tp5n']}}} 03:00:06 INFO - Running post-action listener: _resource_record_post_action 03:00:06 INFO - [mozharness: 2017-07-31 10:00:06.849514Z] Finished populate-webroot step (success) 03:00:06 INFO - [mozharness: 2017-07-31 10:00:06.849657Z] Running create-virtualenv step. 03:00:06 INFO - Running pre-action listener: _resource_record_pre_action 03:00:06 INFO - Running main action method: create_virtualenv 03:00:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:06 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 03:00:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:00:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:06 INFO - Using real prefix '/usr' 03:00:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:09 INFO - Installing pip.................done. 03:00:09 INFO - Return code: 0 03:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:09 INFO - Reading from file tmpfile_stdout 03:00:09 INFO - Output received: 03:00:09 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) 03:00:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:00:09 INFO - Using env: {'DISPLAY': ':0', 03:00:09 INFO - 'HOME': '/home/cltbld', 03:00:09 INFO - 'LANG': 'en_US.UTF-8', 03:00:09 INFO - 'LANGUAGE': 'en_US:en', 03:00:09 INFO - 'LOGNAME': 'cltbld', 03:00:09 INFO - 'MAIL': '/var/mail/cltbld', 03:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:09 INFO - 'MOZ_NO_REMOTE': '1', 03:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:09 INFO - 'NO_EM_RESTART': '1', 03:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:09 INFO - 'PWD': '/builds/slave/test', 03:00:09 INFO - 'SHELL': '/bin/bash', 03:00:09 INFO - 'SHLVL': '1', 03:00:09 INFO - 'TERM': 'linux', 03:00:09 INFO - 'TMOUT': '86400', 03:00:09 INFO - 'USER': 'cltbld', 03:00:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:09 INFO - '_': '/tools/buildbot/bin/python'} 03:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:10 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 03:00:10 INFO - Cleaning up... 03:00:10 INFO - Return code: 0 03:00:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:00:10 INFO - Using env: {'DISPLAY': ':0', 03:00:10 INFO - 'HOME': '/home/cltbld', 03:00:10 INFO - 'LANG': 'en_US.UTF-8', 03:00:10 INFO - 'LANGUAGE': 'en_US:en', 03:00:10 INFO - 'LOGNAME': 'cltbld', 03:00:10 INFO - 'MAIL': '/var/mail/cltbld', 03:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:10 INFO - 'MOZ_NO_REMOTE': '1', 03:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:10 INFO - 'NO_EM_RESTART': '1', 03:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:10 INFO - 'PWD': '/builds/slave/test', 03:00:10 INFO - 'SHELL': '/bin/bash', 03:00:10 INFO - 'SHLVL': '1', 03:00:10 INFO - 'TERM': 'linux', 03:00:10 INFO - 'TMOUT': '86400', 03:00:10 INFO - 'USER': 'cltbld', 03:00:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:10 INFO - '_': '/tools/buildbot/bin/python'} 03:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:10 INFO - Downloading/unpacking psutil>=3.1.1 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:11 INFO - Installing collected packages: psutil 03:00:11 INFO - Running setup.py install for psutil 03:00:11 INFO - building 'psutil._psutil_linux' extension 03:00:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:00:12 INFO - building 'psutil._psutil_posix' extension 03:00:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:12 INFO - Successfully installed psutil 03:00:12 INFO - Cleaning up... 03:00:12 INFO - Return code: 0 03:00:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:00:12 INFO - Using env: {'DISPLAY': ':0', 03:00:12 INFO - 'HOME': '/home/cltbld', 03:00:12 INFO - 'LANG': 'en_US.UTF-8', 03:00:12 INFO - 'LANGUAGE': 'en_US:en', 03:00:12 INFO - 'LOGNAME': 'cltbld', 03:00:12 INFO - 'MAIL': '/var/mail/cltbld', 03:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:13 INFO - 'MOZ_NO_REMOTE': '1', 03:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:13 INFO - 'NO_EM_RESTART': '1', 03:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:13 INFO - 'PWD': '/builds/slave/test', 03:00:13 INFO - 'SHELL': '/bin/bash', 03:00:13 INFO - 'SHLVL': '1', 03:00:13 INFO - 'TERM': 'linux', 03:00:13 INFO - 'TMOUT': '86400', 03:00:13 INFO - 'USER': 'cltbld', 03:00:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:13 INFO - '_': '/tools/buildbot/bin/python'} 03:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:14 INFO - Installing collected packages: mozsystemmonitor 03:00:14 INFO - Running setup.py install for mozsystemmonitor 03:00:14 INFO - Successfully installed mozsystemmonitor 03:00:14 INFO - Cleaning up... 03:00:14 INFO - Return code: 0 03:00:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:14 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')]} 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:14 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')]} 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:14 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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:14 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 03:00:14 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 03:00:14 INFO - Using env: {'DISPLAY': ':0', 03:00:14 INFO - 'HOME': '/home/cltbld', 03:00:14 INFO - 'LANG': 'en_US.UTF-8', 03:00:14 INFO - 'LANGUAGE': 'en_US:en', 03:00:14 INFO - 'LOGNAME': 'cltbld', 03:00:14 INFO - 'MAIL': '/var/mail/cltbld', 03:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:14 INFO - 'MOZ_NO_REMOTE': '1', 03:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:14 INFO - 'NO_EM_RESTART': '1', 03:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:14 INFO - 'PWD': '/builds/slave/test', 03:00:14 INFO - 'SHELL': '/bin/bash', 03:00:14 INFO - 'SHLVL': '1', 03:00:14 INFO - 'TERM': 'linux', 03:00:14 INFO - 'TMOUT': '86400', 03:00:14 INFO - 'USER': 'cltbld', 03:00:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:14 INFO - '_': '/tools/buildbot/bin/python'} 03:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:15 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 03:00:15 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 03:00:15 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 03:00:15 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 03:00:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:15 INFO - warning: no files found matching '*.txt' 03:00:15 INFO - no previously-included directories found matching 'build' 03:00:15 INFO - no previously-included directories found matching 'dist' 03:00:15 INFO - no previously-included directories found matching '.git*' 03:00:15 INFO - Installing collected packages: jsonschema, functools32 03:00:16 INFO - Running setup.py install for functools32 03:00:16 INFO - warning: no files found matching '*.txt' 03:00:16 INFO - no previously-included directories found matching 'build' 03:00:16 INFO - no previously-included directories found matching 'dist' 03:00:16 INFO - no previously-included directories found matching '.git*' 03:00:16 INFO - Successfully installed jsonschema functools32 03:00:16 INFO - Cleaning up... 03:00:16 INFO - Return code: 0 03:00:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:00:16 INFO - Using env: {'DISPLAY': ':0', 03:00:16 INFO - 'HOME': '/home/cltbld', 03:00:16 INFO - 'LANG': 'en_US.UTF-8', 03:00:16 INFO - 'LANGUAGE': 'en_US:en', 03:00:16 INFO - 'LOGNAME': 'cltbld', 03:00:16 INFO - 'MAIL': '/var/mail/cltbld', 03:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:16 INFO - 'MOZ_NO_REMOTE': '1', 03:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:16 INFO - 'NO_EM_RESTART': '1', 03:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:16 INFO - 'PWD': '/builds/slave/test', 03:00:16 INFO - 'SHELL': '/bin/bash', 03:00:16 INFO - 'SHLVL': '1', 03:00:16 INFO - 'TERM': 'linux', 03:00:16 INFO - 'TMOUT': '86400', 03:00:16 INFO - 'USER': 'cltbld', 03:00:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:16 INFO - '_': '/tools/buildbot/bin/python'} 03:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:16 INFO - Cleaning up... 03:00:16 INFO - Return code: 0 03:00:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:00:16 INFO - Using env: {'DISPLAY': ':0', 03:00:16 INFO - 'HOME': '/home/cltbld', 03:00:16 INFO - 'LANG': 'en_US.UTF-8', 03:00:16 INFO - 'LANGUAGE': 'en_US:en', 03:00:16 INFO - 'LOGNAME': 'cltbld', 03:00:16 INFO - 'MAIL': '/var/mail/cltbld', 03:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:16 INFO - 'MOZ_NO_REMOTE': '1', 03:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:16 INFO - 'NO_EM_RESTART': '1', 03:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:16 INFO - 'PWD': '/builds/slave/test', 03:00:16 INFO - 'SHELL': '/bin/bash', 03:00:16 INFO - 'SHLVL': '1', 03:00:16 INFO - 'TERM': 'linux', 03:00:16 INFO - 'TMOUT': '86400', 03:00:16 INFO - 'USER': 'cltbld', 03:00:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:16 INFO - '_': '/tools/buildbot/bin/python'} 03:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:18 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 03:00:18 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 03:00:18 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 03:00:18 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 03:00:18 INFO - Downloading docopt-0.6.1.tar.gz 03:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:18 INFO - Running setup.py install for blobuploader 03:00:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:18 INFO - Running setup.py install for requests 03:00:18 INFO - Running setup.py install for docopt 03:00:18 INFO - Successfully installed blobuploader requests docopt 03:00:18 INFO - Cleaning up... 03:00:18 INFO - Return code: 0 03:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:18 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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:18 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 03:00:18 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 03:00:18 INFO - Using env: {'DISPLAY': ':0', 03:00:18 INFO - 'HOME': '/home/cltbld', 03:00:18 INFO - 'LANG': 'en_US.UTF-8', 03:00:18 INFO - 'LANGUAGE': 'en_US:en', 03:00:18 INFO - 'LOGNAME': 'cltbld', 03:00:18 INFO - 'MAIL': '/var/mail/cltbld', 03:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:18 INFO - 'MOZ_NO_REMOTE': '1', 03:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:18 INFO - 'NO_EM_RESTART': '1', 03:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:18 INFO - 'PWD': '/builds/slave/test', 03:00:18 INFO - 'SHELL': '/bin/bash', 03:00:18 INFO - 'SHLVL': '1', 03:00:18 INFO - 'TERM': 'linux', 03:00:18 INFO - 'TMOUT': '86400', 03:00:18 INFO - 'USER': 'cltbld', 03:00:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:18 INFO - '_': '/tools/buildbot/bin/python'} 03:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:19 INFO - Running setup.py (path:/tmp/pip-uSljWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:19 INFO - Running setup.py (path:/tmp/pip-5u8aOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:19 INFO - Running setup.py (path:/tmp/pip-Bj5N3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:19 INFO - Running setup.py (path:/tmp/pip-_z7V6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:19 INFO - Running setup.py (path:/tmp/pip-ouhlM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:19 INFO - Running setup.py (path:/tmp/pip-G_uJmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:19 INFO - Running setup.py (path:/tmp/pip-41Zr__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:19 INFO - Running setup.py (path:/tmp/pip-Ieb8pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:19 INFO - Running setup.py (path:/tmp/pip-y5Q7fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:19 INFO - Running setup.py (path:/tmp/pip-W6biE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:19 INFO - Running setup.py (path:/tmp/pip-ifK6h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:19 INFO - Running setup.py (path:/tmp/pip-9O8Hsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:19 INFO - Running setup.py (path:/tmp/pip-Z5fUGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:20 INFO - Running setup.py (path:/tmp/pip-nWuzUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:20 INFO - Running setup.py (path:/tmp/pip-WxMDCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:20 INFO - Running setup.py (path:/tmp/pip-TixwtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:20 INFO - Running setup.py (path:/tmp/pip-9ToZV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:20 INFO - Running setup.py install for manifestparser 03:00:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Running setup.py install for mozcrash 03:00:20 INFO - Running setup.py install for mozdebug 03:00:20 INFO - Running setup.py install for mozdevice 03:00:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Running setup.py install for mozfile 03:00:20 INFO - Running setup.py install for mozhttpd 03:00:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Running setup.py install for mozinfo 03:00:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Running setup.py install for mozInstall 03:00:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozleak 03:00:21 INFO - Running setup.py install for mozlog 03:00:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for moznetwork 03:00:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozprocess 03:00:21 INFO - Running setup.py install for mozprofile 03:00:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozrunner 03:00:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozscreenshot 03:00:21 INFO - Running setup.py install for moztest 03:00:21 INFO - Running setup.py install for mozversion 03:00:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:22 INFO - Cleaning up... 03:00:22 INFO - Return code: 0 03:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:22 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')]} 03:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:22 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')]} 03:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:22 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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:22 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 03:00:22 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 03:00:22 INFO - Using env: {'DISPLAY': ':0', 03:00:22 INFO - 'HOME': '/home/cltbld', 03:00:22 INFO - 'LANG': 'en_US.UTF-8', 03:00:22 INFO - 'LANGUAGE': 'en_US:en', 03:00:22 INFO - 'LOGNAME': 'cltbld', 03:00:22 INFO - 'MAIL': '/var/mail/cltbld', 03:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:22 INFO - 'MOZ_NO_REMOTE': '1', 03:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:22 INFO - 'NO_EM_RESTART': '1', 03:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:22 INFO - 'PWD': '/builds/slave/test', 03:00:22 INFO - 'SHELL': '/bin/bash', 03:00:22 INFO - 'SHLVL': '1', 03:00:22 INFO - 'TERM': 'linux', 03:00:22 INFO - 'TMOUT': '86400', 03:00:22 INFO - 'USER': 'cltbld', 03:00:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:22 INFO - '_': '/tools/buildbot/bin/python'} 03:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:22 INFO - Running setup.py (path:/tmp/pip-2fSOtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:22 INFO - Running setup.py (path:/tmp/pip-BrDPvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:22 INFO - Running setup.py (path:/tmp/pip-GVWiB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:22 INFO - Running setup.py (path:/tmp/pip-My8VjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:22 INFO - Running setup.py (path:/tmp/pip-bp2QlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:22 INFO - Running setup.py (path:/tmp/pip-YJnbV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:22 INFO - Running setup.py (path:/tmp/pip-HjEF4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:22 INFO - Running setup.py (path:/tmp/pip-nbKqCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:22 INFO - Running setup.py (path:/tmp/pip-AlW5o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:22 INFO - Running setup.py (path:/tmp/pip-yv6pK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:23 INFO - Running setup.py (path:/tmp/pip-IvNe1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:23 INFO - Running setup.py (path:/tmp/pip-WU8nb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:23 INFO - Running setup.py (path:/tmp/pip-lGD58Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:23 INFO - Running setup.py (path:/tmp/pip-RMAplL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:23 INFO - Running setup.py (path:/tmp/pip-3q2d3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:23 INFO - Running setup.py (path:/tmp/pip-JiZIvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:23 INFO - Running setup.py (path:/tmp/pip-sO0Ysj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:23 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 03:00:23 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 03:00:23 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 03:00:23 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 03:00:24 INFO - Downloading blessings-1.6.tar.gz 03:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:24 INFO - Installing collected packages: blessings 03:00:24 INFO - Running setup.py install for blessings 03:00:24 INFO - Successfully installed blessings 03:00:24 INFO - Cleaning up... 03:00:24 INFO - Return code: 0 03:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:25 INFO - Reading from file tmpfile_stdout 03:00:25 INFO - Current package versions: 03:00:25 INFO - argparse == 1.2.1 03:00:25 INFO - blessings == 1.6 03:00:25 INFO - blobuploader == 1.2.4 03:00:25 INFO - docopt == 0.6.1 03:00:25 INFO - functools32 == 3.2.3-2 03:00:25 INFO - jsonschema == 2.5.1 03:00:25 INFO - manifestparser == 1.1 03:00:25 INFO - mozInstall == 1.13 03:00:25 INFO - mozcrash == 1.0 03:00:25 INFO - mozdebug == 0.1 03:00:25 INFO - mozdevice == 0.51 03:00:25 INFO - mozfile == 1.2 03:00:25 INFO - mozhttpd == 0.7 03:00:25 INFO - mozinfo == 0.10 03:00:25 INFO - mozleak == 0.1 03:00:25 INFO - mozlog == 3.5 03:00:25 INFO - moznetwork == 0.27 03:00:25 INFO - mozprocess == 0.25 03:00:25 INFO - mozprofile == 0.28 03:00:25 INFO - mozrunner == 6.13 03:00:25 INFO - mozscreenshot == 0.1 03:00:25 INFO - mozsystemmonitor == 0.3 03:00:25 INFO - moztest == 0.8 03:00:25 INFO - mozversion == 1.4 03:00:25 INFO - psutil == 3.1.1 03:00:25 INFO - requests == 1.2.3 03:00:25 INFO - wsgiref == 0.1.2 03:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00: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')]} 03:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:25 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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:25 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 03:00:25 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 03:00:25 INFO - Using env: {'DISPLAY': ':0', 03:00:25 INFO - 'HOME': '/home/cltbld', 03:00:25 INFO - 'LANG': 'en_US.UTF-8', 03:00:25 INFO - 'LANGUAGE': 'en_US:en', 03:00:25 INFO - 'LOGNAME': 'cltbld', 03:00:25 INFO - 'MAIL': '/var/mail/cltbld', 03:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:25 INFO - 'MOZ_NO_REMOTE': '1', 03:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:25 INFO - 'NO_EM_RESTART': '1', 03:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:25 INFO - 'PWD': '/builds/slave/test', 03:00:25 INFO - 'SHELL': '/bin/bash', 03:00:25 INFO - 'SHLVL': '1', 03:00:25 INFO - 'TERM': 'linux', 03:00:25 INFO - 'TMOUT': '86400', 03:00:25 INFO - 'USER': 'cltbld', 03:00:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:25 INFO - '_': '/tools/buildbot/bin/python'} 03:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:25 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 03:00:25 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 03:00:25 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 03:00:25 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 03:00:26 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:00:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:00:26 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)) 03:00:26 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)) 03:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:26 INFO - Installing collected packages: marionette-driver, simplejson 03:00:26 INFO - Running setup.py install for marionette-driver 03:00:26 INFO - Running setup.py install for simplejson 03:00:26 INFO - building 'simplejson._speedups' extension 03:00:26 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 03:00:27 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 03:00:27 INFO - Successfully installed marionette-driver simplejson 03:00:27 INFO - Cleaning up... 03:00:27 INFO - Return code: 0 03:00:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:27 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 0xbf01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, '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': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', '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 03:00:27 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 03:00:27 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 03:00:27 INFO - Using env: {'DISPLAY': ':0', 03:00:27 INFO - 'HOME': '/home/cltbld', 03:00:27 INFO - 'LANG': 'en_US.UTF-8', 03:00:27 INFO - 'LANGUAGE': 'en_US:en', 03:00:27 INFO - 'LOGNAME': 'cltbld', 03:00:27 INFO - 'MAIL': '/var/mail/cltbld', 03:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:27 INFO - 'MOZ_NO_REMOTE': '1', 03:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:27 INFO - 'NO_EM_RESTART': '1', 03:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:27 INFO - 'PWD': '/builds/slave/test', 03:00:27 INFO - 'SHELL': '/bin/bash', 03:00:27 INFO - 'SHLVL': '1', 03:00:27 INFO - 'TERM': 'linux', 03:00:27 INFO - 'TMOUT': '86400', 03:00:27 INFO - 'USER': 'cltbld', 03:00:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:27 INFO - '_': '/tools/buildbot/bin/python'} 03:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:28 INFO - Cleaning up... 03:00:28 INFO - Return code: 0 03:00:28 INFO - Running post-action listener: _resource_record_post_action 03:00:28 INFO - Running post-action listener: _start_resource_monitoring 03:00:28 INFO - Starting resource monitoring. 03:00:28 INFO - [mozharness: 2017-07-31 10:00:28.157080Z] Finished create-virtualenv step (success) 03:00:28 INFO - [mozharness: 2017-07-31 10:00:28.158093Z] Running install step. 03:00:28 INFO - Running pre-action listener: _resource_record_pre_action 03:00:28 INFO - Running main action method: install 03:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:28 INFO - Reading from file tmpfile_stdout 03:00:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:28 INFO - Reading from file tmpfile_stdout 03:00:28 INFO - Output received: 03:00:28 INFO - Usage: mozinstall [options] installer 03:00:28 INFO - Options: 03:00:28 INFO - -h, --help show this help message and exit 03:00:28 INFO - -d DEST, --destination=DEST 03:00:28 INFO - Directory to install application into. [default: 03:00:28 INFO - "/builds/slave/test"] 03:00:28 INFO - --app=APP Application being installed. [default: firefox] 03:00:28 INFO - mkdir: /builds/slave/test/build/application 03:00:28 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'] 03:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:00:46 INFO - Reading from file tmpfile_stdout 03:00:46 INFO - Output received: 03:00:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:46 INFO - Running post-action listener: _resource_record_post_action 03:00:46 INFO - [mozharness: 2017-07-31 10:00:46.532486Z] Finished install step (success) 03:00:46 INFO - [mozharness: 2017-07-31 10:00:46.532633Z] Running setup-mitmproxy step. 03:00:46 INFO - Running pre-action listener: _resource_record_pre_action 03:00:46 INFO - Running main action method: setup_mitmproxy 03:00:46 INFO - Skipping: mitmproxy is not required 03:00:46 INFO - Running post-action listener: _resource_record_post_action 03:00:46 INFO - [mozharness: 2017-07-31 10:00:46.533161Z] Finished setup-mitmproxy step (success) 03:00:46 INFO - [mozharness: 2017-07-31 10:00:46.533350Z] Running run-tests step. 03:00:46 INFO - Running pre-action listener: _resource_record_pre_action 03:00:46 INFO - Running pre-action listener: _set_gcov_prefix 03:00:46 INFO - Running main action method: run_tests 03:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:46 INFO - Python 2.7.3 03:00:46 INFO - Return code: 0 03:00:46 INFO - grabbing minidump binary from tooltool 03:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:46 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 0xf5ceb0>, '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 0xf5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:46 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 03:00:46 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 03:00:46 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 03:00:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:46 INFO - Return code: 0 03:00:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:46 INFO - ENV: RUST_BACKTRACE is now 1 03:00:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:46 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/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 03:00:46 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/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 03:00:46 INFO - Using env: {'DISPLAY': ':0', 03:00:46 INFO - 'HOME': '/home/cltbld', 03:00:46 INFO - 'LANG': 'en_US.UTF-8', 03:00:46 INFO - 'LANGUAGE': 'en_US:en', 03:00:46 INFO - 'LOGNAME': 'cltbld', 03:00:46 INFO - 'MAIL': '/var/mail/cltbld', 03:00:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:46 INFO - 'MOZ_NO_REMOTE': '1', 03:00:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:46 INFO - 'NO_EM_RESTART': '1', 03:00:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:46 INFO - 'PWD': '/builds/slave/test', 03:00:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:46 INFO - 'RUST_BACKTRACE': '1', 03:00:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:46 INFO - 'SHELL': '/bin/bash', 03:00:46 INFO - 'SHLVL': '1', 03:00:46 INFO - 'STYLO_FORCE_ENABLED': '1', 03:00:46 INFO - 'TERM': 'linux', 03:00:46 INFO - 'TMOUT': '86400', 03:00:46 INFO - 'USER': 'cltbld', 03:00:46 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794', 03:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:46 INFO - '_': '/tools/buildbot/bin/python'} 03:00:46 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/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 03:00:47 INFO - mozversion application_buildid: 20170731091117 03:00:47 INFO - mozversion application_changeset: 26516ba270816a6cc90f5c42a9b66701369a551f 03:00:47 INFO - mozversion application_display_name: Nightly 03:00:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:47 INFO - mozversion application_name: Firefox 03:00:47 INFO - mozversion application_remotingname: firefox 03:00:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:47 INFO - mozversion application_vendor: Mozilla 03:00:47 INFO - mozversion application_version: 56.0a1 03:00:47 INFO - mozversion platform_buildid: 20170731091117 03:00:47 INFO - mozversion platform_changeset: 26516ba270816a6cc90f5c42a9b66701369a551f 03:00:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:47 INFO - mozversion platform_version: 56.0a1 03:00:47 INFO - using testdate: 1501495247 03:00:47 INFO - actual date: 1501495247 03:00:47 INFO - starting webserver on 'localhost:45926' 03:00:47 INFO - SUITE-START | Running 2 tests 03:00:47 INFO - TEST-START | dromaeo_css 03:00:47 INFO - Initialising browser for dromaeo_css test... 03:00:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45926/getInfo.html -profile /tmp/tmpYzlMyU/profile 03:00:47 INFO - TEST-INFO | started process 3359 (/builds/slave/test/build/application/firefox/firefox http://localhost:45926/getInfo.html) 03:00:55 INFO - TEST-INFO | 3359: exit 0 03:00:55 INFO - Browser initialized. 03:00:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:55 INFO - TEST-INFO | started process 3586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYzlMyU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:56 INFO - PID 3586 | 03:00:56 INFO - PID 3586 | (/builds/slave/test/build/application/firefox/firefox:3640): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:00:56 INFO - PID 3586 | 03:01:07 INFO - PID 3586 | RSS: Main: 173764608 03:01:07 INFO - PID 3586 | 03:04:07 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:45926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45926/tests/dromaeo/cssquery-ext.html) 03:04:08 INFO - PID 3586 | RSS: Main: 173035520 03:04:08 INFO - PID 3586 | 03:07:10 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:45926/tests/dromaeo/cssquery-ext.html (next: http://localhost:45926/tests/dromaeo/cssquery-jquery.html) 03:07:11 INFO - PID 3586 | RSS: Main: 170921984 03:07:11 INFO - PID 3586 | 03:10:12 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:45926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45926/tests/dromaeo/cssquery-mootools.html) 03:10:13 INFO - PID 3586 | RSS: Main: 175226880 03:10:13 INFO - PID 3586 | 03:13:15 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:45926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45926/tests/dromaeo/cssquery-prototype.html) 03:13:16 INFO - PID 3586 | RSS: Main: 173694976 03:13:16 INFO - PID 3586 | 03:16:20 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:45926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45926/tests/dromaeo/cssquery-yui.html) 03:16:20 INFO - PID 3586 | RSS: Main: 176996352 03:16:20 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:45926/tests/dromaeo/cssquery-yui.html (next: http://localhost:45926/tests/dromaeo/cssquery-dojo.html) 03:19:22 INFO - PID 3586 | RSS: Main: 177627136 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | __start_tp_report 03:19:22 INFO - PID 3586 | _x_x_mozilla_page_load 03:19:22 INFO - PID 3586 | _x_x_mozilla_page_load_details 03:19:22 INFO - PID 3586 | |i|pagename|runs| 03:19:22 INFO - PID 3586 | |0;dojo.html;3128.9687103128963;3157.621085469744;3159.8420078996046;3176.380605781872;3190.601174853142;6146.877062458754;6151.569390142692;6180.320164781876;6208;6340.017297318911;6250.9062364064575;6295.370462953714;6315.652639104847;6336.7465301388;6349.809505714825;5563.693996830173;5635.267415236024;5665.716714164296;5748.655080695151;5814.534837213034;5640.689762063085;5686.09022556391;5781.046127388976;5794.623349482291;5804.129380592903;5662.66024038559;5675.772969081232;5701.600887937846;5767.711614419262;5778.162166485857;5547.528460080898;5654.773809047633;5721.4850663440075;5734.8279551613105;5779.190913272145;5614.214010038598;5618.91571626426;5679.886402271973;5706.229658996065;5707.74315155819;6187.102870083858;6219.378062193789;6227.221597300338;6235.314115447297;6274.937250627481;6681.565698229648;6691.899621505681;6728.562643428161;6795.898061529081;6800.727970881158;6595.835104122388;6738.427233685143;6758.9324106758795;6771.661416929134;6870.381665650066;6161.322254551996;6222.284437289679;6223.502119830448;6224.502039836802;6226.937730622726;6822.863542729117;6853.828654283583;6856.828579285558;6857.588544687235;6879.380855723009;6575.342465753482;6579.934200657932;6580.5064620152725;6580.967095164589;6584.473242140617;6647.302033286435;6654.301298363699;6670.199576050905;6686.5653732507235;6690.598564086073;6613.3056029117215;6630.071789949411;6641.335866413417;6651.102101216274;6663.566868153554;6683.198016237985;6697.497687673444;6771.8984215236815;6774.559653622498;6793.966030169818;5306.336707911511;5346.732663366816;5378.838634840961;5448.618596698193;5450.727463626803;4610.53894610543;4620.861374158781;4630.259158534618;4634.976825115853;4726.149293127201;5817.301923769175;5818;5833.88332233353;5838.2702162229725;5853;6781.25406205317;6796.76211332601;6799.422049125879;6807.455403567802;6812.318768123148;5768.826935191951;5780.913286300709;5861.0915308127305;5888.234529511136;5891.175235467038;5816.272965879265;5855.882882342415;5856.912146317809;5858.794942177004;5928.496077833346;6469.385408386196;6470.967645161838;6545;6549.279579246279;6551.279359270477;6254.749810007549;6717.731290748316;6729.259781423942;6793.830154245986;6833.58998460094;6443.548951573345;6488.318726533646;6577.440917522064;6589.242237142598;6592.868142637216;6458.321876203119;6538.444232240313;6553.541252112306;6575.4410875076155;6689.933100668931;6677.866442671022;6693.1298931138645;6696.062551242927;6704.027915952062;6704.061431399706;6397.840053998687;6456.160699109086;6478.352164783484;6487.643179625166;6490.286068532552;6457;6460.547761656639;6482.513811464065;6496.0255961606135;6501.349865013461;5595.244641973281;6356.936430635635;6380.106785050004;6420.972644376878;6517.055027020961;6500.772472963424;6528.151340325728;6543.083968244355;6640.966795165993;6657.167854018247;6220.813375598739;6300.2754683212015;6301.275353334242;6338.556301058881;6413.134226879311 03:19:22 INFO - PID 3586 | |1;ext.html;839.588601585223;877.2981614708234;899.4423457456378;901.3059943843239;1187.1333926233854;39718.602813971855;43354.349684754714;43368.566314336844;43390.349144762855;43499.78250108753;43088.3536746949;43413.56586434135;43444.348334775;43517.34723979143;43551.34672979908;7268.491205615609;7746.92253077469;7879.1726868678825;7884.408669349793;7885.8028549286155;7738.651760670783;7863.292303692667;7865.606719663994;7870.724524641639;7871.134175240719;7803.726869559567;7828.725994590191;7835.882461763078;7873.370130389555;7882.093559240675;7821.76534703957;7836.098848632423;7848.13670496245;7848.136704962507;7856.057273127204;7668.501547399401;7741.458097933147;7763.883541746822;7766.766996990099;7791.22087791222;38683.22633547313;38971;39128.217435651415;39136.41295380572;39200.60799392027;3511.0695665648623;3535.398982173011;3538.3630946429635;3547.1486843157713;3547.2728090741334;30871.073867784;30931.226719332197;30998.535021974687;31006.534901976487;31072;4591.51789062147;4607.35497030416;4664.067186562701;4691.7654117294;4754.286856971447;186144;186210;186426;186656.99999999863;187294;49584.256236156485;49846;49924.50075499198;50093.24860127101;50153.74923125361;51913;51967.22049169266;52089.47910520846;52416;52416.21375679368;14977.475788347356;15321.004134731207;16402.179891005402;16650;16682.332706691595;13552.932235338958;13689.520866769615;13721.519746808814;13738.931305343409;13739.931300343434;14675.633109172357;14779.556613301618;14832.925835370754;14853.405863765329;14941.477048303475;5913.556483263773;5935.762569497172;5976.282846058501;6000.729967151488;6003.849903752441;972.8297547929084;986.063239922077;996.7059717383389;1003.6988903328972;1005.8541511480794;22981.195658151886;23350.883245584002;23578.646320305208;23642.81785910732;24084.51830963371;1064.302881612545;1079.7138758229075;1087.543231842628;1090.0571006079842;1101.6970333158445;11368.204225704287;11732.178747487595;11934.104942129376;12015;12124.090693198046;222316;223193;224520;224980;225349;52053.7397313011;52424.737876311134;52506;52580.47419525832;52655;1461.9269036548342;1484.317214081513;1509.645233370157;1511.3727802961866;1520.695860827839;21876.343709688736;21895.78104219001;21955.67066493972;22000.229991950204;22511.887440562692;36598.268034638626;37000.25999480049;37047.81476092602;37338;51977;211731;211995;213549;214013;214418;35431.46852797262;35967.82016089903;36277.63722362848;36311.455328170625;37304.25391492209;47508.7624561875;47817.52182478131;47830;47844.28233576569;48235.276470852266;27257.31856703598;27851.721482785724;28702.712972870006;28825.855870720512;29080.7091929078;26380.8680956594;28011;28582.42835143327;28629.427411451237;28844;37136;37796.811015945845;37797.62202377941;37805.81097094497;37989.620103799716;31456.52815207728;33166.502502462965;33620.663793362735;33875;34019.4897076549;23707.52584948326;24650.383740406633;24724.752752472246;24736.25791226266;24904.62643060392 03:19:22 INFO - PID 3586 | |2;jquery.html;562.569634229814;567.1804242869056;568.6616463204394;572.3046498504316;581.9796307129251;19027.714584281246;22495.662565061517;23235.186768463107;23310.41723956902;23328.416789580268;26766.5985010225;27377.589336159974;27442.45115097697;27448.17655470339;27524;7127.28727127287;7266.091738532684;7307.050083489139;7343.559386436831;7347.963260183692;6245;6683.799486015403;6984.5110842241065;6991.755288564901;7030.156381234259;6924.58452492852;6964.164300283973;6992.6853291602;6999.12510936133;7015.403690686272;6981.441484681239;6996.580205187705;7017.47368947331;7019.052427922267;7024.894626580605;6839.692213850389;6846.212685541177;6848.554843935178;6864.176298844171;6882.346177113166;30049.849750751324;31259.531107033185;32038.519422208687;32185.51721724176;32302.192445188823;1954.7654281486314;1986.6523358412364;1996.8502362322738;1997.3808119482862;1997.680371140625;19896.502587435287;20679.172833086657;20721;20748.377548673565;20783.792162078487;2316.9073237070497;2457.7910877575428;2544.9872750636314;2557.373443506353;2567.101514469939;143257;145950;146106;146351;146510;20207.69688454674;21577.67633485499;21791.23730669419;21969.825733110658;22596.98986628301;44010.55989440065;44082.33876491855;44125;44191.33712994308;44201;10517.9474102629;10520.421376824195;10715.749692564494;10730.678079657622;10914.890851091546;8624.490714125002;8702.869456958151;8710.825783484295;8904.688335908211;9438.339316247933;9312.580933857993;9390.85913711295;9452.109578084273;9564.234861211087;9604.127195197008;2891.181098429057;2899.767179271949;2900.347421830071;2920.941581168365;2960.3883262419813;970.4322971062007;972.557486343726;974.8976357482504;1008.8133695266399;1021.5454122915231;19529.414117576496;19742.90128549348;19804.20783168686;20205.494862628257;23202.41993950131;1015.2334987084852;1025.9025392587841;1035.8378330703795;1049.9895001050045;1050.9054185123375;11011.229213955106;11035.613753518588;11290.322580645023;11314;11362.48868800906;527332;528757;536040;536909;537440;117571.41214293875;120106.39946800384;121280.39359803144;121915.39042304731;122504;1250.3435696259537;1259.3262604506729;1285.1068507387463;1293.7606542789615;1303.67408147963;16854;18010;18206.45380638583;18496.537586559905;18849.434516964513;53586.46413535815;56441;58099.70950145222;58793.70603146957;60011.39988600058;71871.64064179646;72444;72463.27536724565;72768.27231727615;73215.63392183006;12315.876841231473;12897.41961611711;14283.714325713636;14438.639034024234;14833;23310.76689233154;23395.298141055795;23511.41221469477;23661.64507532354;23687.763122369244;18138.274469021093;18271.908640456713;18283.360082397052;18591.90704046471;18685.90657046706;14254.572362829133;15221.162836044125;15306.540803775904;15366.308516116578;15683.529494115195;18737.531561711065;18874.24503019864;19068.141933613297;19081;20319.49201269921;14970.101793892401;14992.400303988155;15070.773938390714;15118.470853520073;15136.772948405562;17875.910620446815;18417.723734143732;18793.342233022326;18796.530086747392;18815.435536933914 03:19:22 INFO - PID 3586 | |3;mootools.html;1375.717977814548;1423.7152569486104;1426.721789251095;1436.3105709259562;1439.978400323995;13691.110077844933;13943.16341019537;14327.212003339811;14360;14418;12826.166299190547;12962.351882405888;12971.156874803155;12972.481100755982;13005.219686818797;2643.8149329546986;2705.878235479408;2706.5534186859145;2707.2284398946304;2708.377073273148;2590.0546300600336;2677.611746296786;2754.297654098202;2755.256080858167;2759.0481283957;2516.7860731837723;2528.633348164515;2557.3734435063434;2560.8207425480223;2561.5773397389407;2580.071174377232;2618.4763047390597;2627.737226277376;2633.7102918679025;2679.5712685970248;2494.5135698538793;2541.4154744408706;2565.076572433922;2573.1122762646855;2607.035396903139;14191.148531088167;14268.215248161347;14273.214973176471;14295.78556321656;14296.285185740671;7316.926830731678;7547.358474529671;7577.583232922187;7610.657520411595;7611.80970475737;4784.760761961888;5017.874553136165;5203.843884683465;5204.3234379530795;5214.139666954986;1593.3228377939329;1637.6806522728073;1682.6802907447668;1688.8817782755211;1691.4671878358279;22606.32181034555;22941.31176064704;22965.54068918629;23102;23107.653385199068;6181.598196117238;6359.682015899187;6368.42684158428;6537.934620653828;6582.637954912526;15910.602234943988;15990.280437380346;16033.358665653477;16091.114988675501;16092.919535402249;7357.2642735726;7517.473776835678;7521.398288136936;7521.7367392142105;7524.548527088392;6635.5023373247195;6819.829504262334;6869.7595584154315;6958.47811414146;6989.47578931572;5034.270030845581;5050.797968081236;5059.392872855281;5149.613778966593;5168.9741551292;1369.452219112363;1451.7459444597364;1457.453454954392;1462.8098347214793;1528.740114180592;825.4304529874488;827.5489858027389;845.5814371885956;864.446754077391;888.9466632002101;7173.354398104091;7263.382612477999;7474.40204783616;7523.962380188064;7529.774106776806;920.9907900921039;941.1247539787926;966.4539535162611;968.4576637083256;983.1544871410581;4002.539707933625;4280.101178752435;4954.355933728592;4991.625628077836;5012.8496145115705;19113.235470581298;19570.60858782845;19601.705974410394;19610.60778784445;19643.508912277306;18014.729779053323;18905.905470472833;19056.52358691044;19205.32781352646;19252.326168584033;10656.786864262827;10855.457227138611;10862.78274434507;10914.617988370368;10916.617918372818;7199.42476506235;7376.852462950818;7728.304452599293;7800.492967957065;7979.082405523439;15635.374585016472;16458.09480478585;16504.33982640729;16827.158642067603;17314;16415.9179204108;16854.1572921351;17106.374894385015;17249.31002759926;17264.48206553755;11272.605458808903;11376.715582110513;11500.424978750862;11640.825387619023;11689.415529223335;13093.41079651437;13246.271455070064;13252.20486770797;13256.801147982595;13271.203727776365;9783.706488805346;9998.800023999334;10206.23453240995;10343.63797267092;10401.27191096616;9629.229661626912;10236.897631023594;10314.174866010851;10325.483725813829;10480.213983951387;8601.440906341068;8764.561771911507;8769.956150219208;8771.56142192875;8777.253933415732;5945;6101.877962440638;6365.427111559982;6391.6804159792755;6445.709943052668;6299.685015749103;6420.229572451149;6583;6742.325767423218;6851.212110607344 03:19:22 INFO - PID 3586 | |4;prototype.html;487.83894331491024;509.5668681620623;533.3413234655203;533.8505218538809;534.3614380814928;6151.4463698267145;6154.661493617855;6238.157848690425;6276.592021518603;6287.528435367343;5999.940000599992;6031.24609423822;6111.480524155441;6152.723127459264;6187.102870083835;4942.209246520558;4964.851054468371;4987.62592805541;5005.674631148972;5006.874828129289;4901.68139070961;4926.729029903354;4978.975105124469;4986.030517945409;5006.173981293082;4669.719816811003;4802.759862006903;4850.393700787402;4893.9934626803015;4907.4356449008465;4825.20384136617;4855.198892182803;4860.816165411661;4880.194767863299;4931.112399768041;4276.764777937212;4326.394304797331;4332.155229730204;4375.365571992043;4407.559244075567;5916.556258280646;5997.490213331872;6026.564858030924;6084.421979911901;6097.237845269341;5645.15322701594;5650.29371328584;5671.404502527258;5682.488576028178;5692.6299790513485;6372.426481616677;6408.871822563523;6433.549651524395;6437.549371543993;6501.837454063639;4777.235642297251;4777.880552986203;4778.665493415462;4805.543473370024;4858.271259311096;6801;6830.59016459014;6892.517523773338;6896.620685862225;6919.584824910521;4894.437139728977;4928.137575924199;4950.925736113961;4976.2286845539;4983.526564976321;5051.621128415383;5059.392872855207;5060.468650791614;5078;5084.745762711849;5662.8301150965535;5676.148577713376;5676.262085928803;5705.800296989585;5724.484796368263;6456.257530383972;6476.708548115346;6494.642794646245;6516.674166291761;6558.573692709959;1661.4932445604206;1722.5349155727883;1744.0669241955493;1749.7025505664067;1759.2347328911965;1162.7616338650557;1186.9287842729464;1204.8433703618473;1219.7375716133758;1243.6890777305673;5544.445555444504;5553.77784888608;5580.079286917694;5586.804461843816;5633.943660563424;6448.355164483514;6462.4183823456115;6471.805845824632;6506.512011599149;6622.966885165543;5577.358603760619;5634.32388113429;5744.942550574441;5761.53907687384;5837.562182836219;3548.4854696068924;3570.4465807799834;3595.424732042861;3604.6575575320303;3623.384024715752;6441.645709486023;6448.516361272923;6453.225612926385;6466.482681385478;6476.805695829133;6703.631300278434;6734.292899245509;6802.455803535705;6833.692483838239;6863.38229559342;6335.65153916539;6345.270293916259;6435.871282574416;6441;6508;6659.300773418721;6664.034109937483;6685.930251159791;6697.330266973264;6740.528163028541;6623;6636.336366363325;6637.4690024798865;6654.800355989328;6696.229933557508;6416.165898433173;6507.479401647952;6515.250746164252;6520.250171230369;6535.836604084936;4962.950370496394;4976.800927962841;4983.725895075806;4987.102321582005;5009.597312752435;6638.800835974928;6682.264950855305;6687.431568316553;6768.255491895986;6797.864042719217;6470.352964703492;6492.448141907991;6505.837354066186;6528.21661400635;6565.409113179837;6445.6454894981225;6471.967640161769;6477.708503117466;6514.9348506514325;6568;6082.482988945989;6241.21984751906;6292.653904035322;6323.430891219812;6398.264199617103;6207.410296021871;6434.2922278548385;6535.5425120241125;6548.8035358939305;6565.606063636197;6230.657313847782;6271.937280627318;6291.339409361951;6318.747250109944;6374.310807636073 03:19:22 INFO - PID 3586 | |5;yui.html;870.4385671242053;899.6896070855555;925.2644147902417;927.5315965437453;928.6981730937447;17678.469645910627;18575.535611609717;18596.163172657212;18610.81389186108;18677.533061673465;17427.825721742778;17575.38486152985;20151.596968060665;21727;21885.234016809416;1003.7202566727408;1038.9480525973709;1042.3329069395593;1043.0560342889696;1043.243648354944;985.1626117799884;1025.6717850287912;1040.885502594714;1040.9375437473775;1046.4192373232852;1074.8119079161115;1077.0737166037202;1077.6982444915398;1081.2377274021796;1083.664064140119;1064.3720205079003;1072.2922870905204;1072.5924148823397;1073.0825144501455;1073.3238060022136;784.8861915022347;790.9011373578303;791.1020991175058;797.4059325802315;797.9760607181794;18927.526811829677;19178.520536986547;19306.4208073758;19416.708749368772;19687.31094411703;20583.279585214445;20614.896925515277;21045.684314735292;21085.8945705272;21175.68236476454;15724.842751572452;15922.442714504938;16023.91988040064;16114;16116.83883161165;3544.220271540257;3548.2193917338145;3553.0051585556084;3575.0704816747575;3578.141246100943;121860;124790;127768.80577985532;129004;130752.34623826915;15632.2183890805;15782.289796958934;15929.203539822962;16046.67906641884;16134.112623805804;29677;30164.396712065634;30269.848650756605;30320.241993949887;30341.544876826865;8085.878711819328;8266.793330166674;8298.875516867252;8304.58477076156;8305.709300174465;4269.146170765859;4327.675424343187;4365.257906155961;4368.737875727466;4370.628496577827;5118.053160165381;5223.608229382811;5263.473652634782;5297.708626025606;5306.681599104066;935.209747763139;957.8371676814958;971.4996776660025;975.8048390321964;978.9021097890296;654.4044919123575;668.4986260304771;686.4165459359505;711.2567367101392;718.5509056839476;11072.778544429066;11466.713332166762;12141.69645758863;12777.488900443877;13453.192808431526;635.5392340553154;674.3357792574409;698.783377153074;699.9615021173782;706.1138271469273;5291.259223708684;5474.835754927359;5659.632123912015;5725.971370143123;5978.850528736816;98691;99608.50195748975;102060.48969755252;102355;104251;84681;85195;90714;90936;92798;76025;77471.61264193755;80184;83492.58253708693;85735;11548.133889958455;12743.553975610808;12818.935905320413;12916.031297652902;12948.8057679133;35781;36212.637373212994;36358.454623181206;36530.634693652726;37283.254334912606;45557.77221114006;46329.768351158025;46343.76828115838;47181.76409117933;68043.49346898487;18889.433317000512;19285.710714339017;19348.8065119347;19630.705539416635;19640.705389419454;21532.246371376925;21795.23716669909;22107.77892221057;22494;22554.210602628827;18476.815231848046;19333.709994349814;19695.803041969397;19813.108410121866;19967.60064798725;18742.718859217395;19377.321793737152;19443.51391215231;19517.219311227393;19743.802561974197;18234.088295585432;18285.085745712397;18293.26826926908;18707.71938420952;18801.435956921316;12922.483100675867;12947.352632368156;13116.01629877782;13354.198748075147;13548.187108773505;13413.463461461432;13878;14207.792337651415;14400.927995359956;14723.411063557765 03:19:22 INFO - PID 3586 | __end_tp_report 03:19:22 INFO - PID 3586 | __start_cc_report 03:19:22 INFO - PID 3586 | _x_x_mozilla_cycle_collect,384 03:19:22 INFO - PID 3586 | __end_cc_report 03:19:22 INFO - PID 3586 | __startTimestamp1501496362813__endTimestamp 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | ------- Summary: start ------- 03:19:22 INFO - PID 3586 | Number of tests: 6 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | [#0] dojo.html Cycles:165 Average:6152.06 Median:6380.11 stddev:729.47 (11.4%) stddev-sans-first:692.08 03:19:22 INFO - PID 3586 | Values: 3129.0 3157.6 3159.8 3176.4 3190.6 6146.9 6151.6 6180.3 6208.0 6340.0 6250.9 6295.4 6315.7 6336.7 6349.8 5563.7 5635.3 5665.7 5748.7 5814.5 5640.7 5686.1 5781.0 5794.6 5804.1 5662.7 5675.8 5701.6 5767.7 5778.2 5547.5 5654.8 5721.5 5734.8 5779.2 5614.2 5618.9 5679.9 5706.2 5707.7 6187.1 6219.4 6227.2 6235.3 6274.9 6681.6 6691.9 6728.6 6795.9 6800.7 6595.8 6738.4 6758.9 6771.7 6870.4 6161.3 6222.3 6223.5 6224.5 6226.9 6822.9 6853.8 6856.8 6857.6 6879.4 6575.3 6579.9 6580.5 6581.0 6584.5 6647.3 6654.3 6670.2 6686.6 6690.6 6613.3 6630.1 6641.3 6651.1 6663.6 6683.2 6697.5 6771.9 6774.6 6794.0 5306.3 5346.7 5378.8 5448.6 5450.7 4610.5 4620.9 4630.3 4635.0 4726.1 5817.3 5818.0 5833.9 5838.3 5853.0 6781.3 6796.8 6799.4 6807.5 6812.3 5768.8 5780.9 5861.1 5888.2 5891.2 5816.3 5855.9 5856.9 5858.8 5928.5 6469.4 6471.0 6545.0 6549.3 6551.3 6254.7 6717.7 6729.3 6793.8 6833.6 6443.5 6488.3 6577.4 6589.2 6592.9 6458.3 6538.4 6553.5 6575.4 6689.9 6677.9 6693.1 6696.1 6704.0 6704.1 6397.8 6456.2 6478.4 6487.6 6490.3 6457.0 6460.5 6482.5 6496.0 6501.3 5595.2 6356.9 6380.1 6421.0 6517.1 6500.8 6528.2 6543.1 6641.0 6657.2 6220.8 6300.3 6301.3 6338.6 6413.1 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | [#1] ext.html Cycles:180 Average:38054.76 Median:36294.55 stddev:54064.80 (149.0%) stddev-sans-first:54144.25 03:19:22 INFO - PID 3586 | Values: 839.6 877.3 899.4 901.3 1187.1 39718.6 43354.3 43368.6 43390.3 43499.8 43088.4 43413.6 43444.3 43517.3 43551.3 7268.5 7746.9 7879.2 7884.4 7885.8 7738.7 7863.3 7865.6 7870.7 7871.1 7803.7 7828.7 7835.9 7873.4 7882.1 7821.8 7836.1 7848.1 7848.1 7856.1 7668.5 7741.5 7763.9 7766.8 7791.2 38683.2 38971.0 39128.2 39136.4 39200.6 3511.1 3535.4 3538.4 3547.1 3547.3 30871.1 30931.2 30998.5 31006.5 31072.0 4591.5 4607.4 4664.1 4691.8 4754.3 186144.0 186210.0 186426.0 186657.0 187294.0 49584.3 49846.0 49924.5 50093.2 50153.7 51913.0 51967.2 52089.5 52416.0 52416.2 14977.5 15321.0 16402.2 16650.0 16682.3 13552.9 13689.5 13721.5 13738.9 13739.9 14675.6 14779.6 14832.9 14853.4 14941.5 5913.6 5935.8 5976.3 6000.7 6003.8 972.8 986.1 996.7 1003.7 1005.9 22981.2 23350.9 23578.6 23642.8 24084.5 1064.3 1079.7 1087.5 1090.1 1101.7 11368.2 11732.2 11934.1 12015.0 12124.1 222316.0 223193.0 224520.0 224980.0 225349.0 52053.7 52424.7 52506.0 52580.5 52655.0 1461.9 1484.3 1509.6 1511.4 1520.7 21876.3 21895.8 21955.7 22000.2 22511.9 36598.3 37000.3 37047.8 37338.0 51977.0 211731.0 211995.0 213549.0 214013.0 214418.0 35431.5 35967.8 36277.6 36311.5 37304.3 47508.8 47817.5 47830.0 47844.3 48235.3 27257.3 27851.7 28702.7 28825.9 29080.7 26380.9 28011.0 28582.4 28629.4 28844.0 37136.0 37796.8 37797.6 37805.8 37989.6 31456.5 33166.5 33620.7 33875.0 34019.5 23707.5 24650.4 24724.8 24736.3 24904.6 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | [#2] jquery.html Cycles:180 Average:37378.83 Median:23272.80 stddev:89570.66 (384.9%) stddev-sans-first:89779.28 03:19:22 INFO - PID 3586 | Values: 562.6 567.2 568.7 572.3 582.0 19027.7 22495.7 23235.2 23310.4 23328.4 26766.6 27377.6 27442.5 27448.2 27524.0 7127.3 7266.1 7307.1 7343.6 7348.0 6245.0 6683.8 6984.5 6991.8 7030.2 6924.6 6964.2 6992.7 6999.1 7015.4 6981.4 6996.6 7017.5 7019.1 7024.9 6839.7 6846.2 6848.6 6864.2 6882.3 30049.8 31259.5 32038.5 32185.5 32302.2 1954.8 1986.7 1996.9 1997.4 1997.7 19896.5 20679.2 20721.0 20748.4 20783.8 2316.9 2457.8 2545.0 2557.4 2567.1 143257.0 145950.0 146106.0 146351.0 146510.0 20207.7 21577.7 21791.2 21969.8 22597.0 44010.6 44082.3 44125.0 44191.3 44201.0 10517.9 10520.4 10715.7 10730.7 10914.9 8624.5 8702.9 8710.8 8904.7 9438.3 9312.6 9390.9 9452.1 9564.2 9604.1 2891.2 2899.8 2900.3 2920.9 2960.4 970.4 972.6 974.9 1008.8 1021.5 19529.4 19742.9 19804.2 20205.5 23202.4 1015.2 1025.9 1035.8 1050.0 1050.9 11011.2 11035.6 11290.3 11314.0 11362.5 527332.0 528757.0 536040.0 536909.0 537440.0 117571.4 120106.4 121280.4 121915.4 122504.0 1250.3 1259.3 1285.1 1293.8 1303.7 16854.0 18010.0 18206.5 18496.5 18849.4 53586.5 56441.0 58099.7 58793.7 60011.4 71871.6 72444.0 72463.3 72768.3 73215.6 12315.9 12897.4 14283.7 14438.6 14833.0 23310.8 23395.3 23511.4 23661.6 23687.8 18138.3 18271.9 18283.4 18591.9 18685.9 14254.6 15221.2 15306.5 15366.3 15683.5 18737.5 18874.2 19068.1 19081.0 20319.5 14970.1 14992.4 15070.8 15118.5 15136.8 17875.9 18417.7 18793.3 18796.5 18815.4 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | [#3] mootools.html Cycles:180 Average:8536.36 Median:2576.59 stddev:5913.95 (229.5%) stddev-sans-first:5906.07 03:19:22 INFO - PID 3586 | Values: 1375.7 1423.7 1426.7 1436.3 1440.0 13691.1 13943.2 14327.2 14360.0 14418.0 12826.2 12962.4 12971.2 12972.5 13005.2 2643.8 2705.9 2706.6 2707.2 2708.4 2590.1 2677.6 2754.3 2755.3 2759.0 2516.8 2528.6 2557.4 2560.8 2561.6 2580.1 2618.5 2627.7 2633.7 2679.6 2494.5 2541.4 2565.1 2573.1 2607.0 14191.1 14268.2 14273.2 14295.8 14296.3 7316.9 7547.4 7577.6 7610.7 7611.8 4784.8 5017.9 5203.8 5204.3 5214.1 1593.3 1637.7 1682.7 1688.9 1691.5 22606.3 22941.3 22965.5 23102.0 23107.7 6181.6 6359.7 6368.4 6537.9 6582.6 15910.6 15990.3 16033.4 16091.1 16092.9 7357.3 7517.5 7521.4 7521.7 7524.5 6635.5 6819.8 6869.8 6958.5 6989.5 5034.3 5050.8 5059.4 5149.6 5169.0 1369.5 1451.7 1457.5 1462.8 1528.7 825.4 827.5 845.6 864.4 888.9 7173.4 7263.4 7474.4 7524.0 7529.8 921.0 941.1 966.5 968.5 983.2 4002.5 4280.1 4954.4 4991.6 5012.8 19113.2 19570.6 19601.7 19610.6 19643.5 18014.7 18905.9 19056.5 19205.3 19252.3 10656.8 10855.5 10862.8 10914.6 10916.6 7199.4 7376.9 7728.3 7800.5 7979.1 15635.4 16458.1 16504.3 16827.2 17314.0 16415.9 16854.2 17106.4 17249.3 17264.5 11272.6 11376.7 11500.4 11640.8 11689.4 13093.4 13246.3 13252.2 13256.8 13271.2 9783.7 9998.8 10206.2 10343.6 10401.3 9629.2 10236.9 10314.2 10325.5 10480.2 8601.4 8764.6 8770.0 8771.6 8777.3 5945.0 6101.9 6365.4 6391.7 6445.7 6299.7 6420.2 6583.0 6742.3 6851.2 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | [#4] prototype.html Cycles:180 Average:5454.22 Median:6083.45 stddev:1531.43 (25.2%) stddev-sans-first:1489.67 03:19:22 INFO - PID 3586 | Values: 487.8 509.6 533.3 533.9 534.4 6151.4 6154.7 6238.2 6276.6 6287.5 5999.9 6031.2 6111.5 6152.7 6187.1 4942.2 4964.9 4987.6 5005.7 5006.9 4901.7 4926.7 4979.0 4986.0 5006.2 4669.7 4802.8 4850.4 4894.0 4907.4 4825.2 4855.2 4860.8 4880.2 4931.1 4276.8 4326.4 4332.2 4375.4 4407.6 5916.6 5997.5 6026.6 6084.4 6097.2 5645.2 5650.3 5671.4 5682.5 5692.6 6372.4 6408.9 6433.5 6437.5 6501.8 4777.2 4777.9 4778.7 4805.5 4858.3 6801.0 6830.6 6892.5 6896.6 6919.6 4894.4 4928.1 4950.9 4976.2 4983.5 5051.6 5059.4 5060.5 5078.0 5084.7 5662.8 5676.1 5676.3 5705.8 5724.5 6456.3 6476.7 6494.6 6516.7 6558.6 1661.5 1722.5 1744.1 1749.7 1759.2 1162.8 1186.9 1204.8 1219.7 1243.7 5544.4 5553.8 5580.1 5586.8 5633.9 6448.4 6462.4 6471.8 6506.5 6623.0 5577.4 5634.3 5744.9 5761.5 5837.6 3548.5 3570.4 3595.4 3604.7 3623.4 6441.6 6448.5 6453.2 6466.5 6476.8 6703.6 6734.3 6802.5 6833.7 6863.4 6335.7 6345.3 6435.9 6441.0 6508.0 6659.3 6664.0 6685.9 6697.3 6740.5 6623.0 6636.3 6637.5 6654.8 6696.2 6416.2 6507.5 6515.3 6520.3 6535.8 4963.0 4976.8 4983.7 4987.1 5009.6 6638.8 6682.3 6687.4 6768.3 6797.9 6470.4 6492.4 6505.8 6528.2 6565.4 6445.6 6472.0 6477.7 6514.9 6568.0 6082.5 6241.2 6292.7 6323.4 6398.3 6207.4 6434.3 6535.5 6548.8 6565.6 6230.7 6271.9 6291.3 6318.7 6374.3 03:19:22 INFO - PID 3586 | 03:19:22 INFO - PID 3586 | [#5] yui.html Cycles:180 Average:22536.58 Median:20599.09 stddev:30014.79 (145.7%) stddev-sans-first:30054.90 03:19:22 INFO - PID 3586 | Values: 870.4 899.7 925.3 927.5 928.7 17678.5 18575.5 18596.2 18610.8 18677.5 17427.8 17575.4 20151.6 21727.0 21885.2 1003.7 1038.9 1042.3 1043.1 1043.2 985.2 1025.7 1040.9 1040.9 1046.4 1074.8 1077.1 1077.7 1081.2 1083.7 1064.4 1072.3 1072.6 1073.1 1073.3 784.9 790.9 791.1 797.4 798.0 18927.5 19178.5 19306.4 19416.7 19687.3 20583.3 20614.9 21045.7 21085.9 21175.7 15724.8 15922.4 16023.9 16114.0 16116.8 3544.2 3548.2 3553.0 3575.1 3578.1 121860.0 124790.0 127768.8 129004.0 130752.3 15632.2 15782.3 15929.2 16046.7 16134.1 29677.0 30164.4 30269.8 30320.2 30341.5 8085.9 8266.8 8298.9 8304.6 8305.7 4269.1 4327.7 4365.3 4368.7 4370.6 5118.1 5223.6 5263.5 5297.7 5306.7 935.2 957.8 971.5 975.8 978.9 654.4 668.5 686.4 711.3 718.6 11072.8 11466.7 12141.7 12777.5 13453.2 635.5 674.3 698.8 700.0 706.1 5291.3 5474.8 5659.6 5726.0 5978.9 98691.0 99608.5 102060.5 102355.0 104251.0 84681.0 85195.0 90714.0 90936.0 92798.0 76025.0 77471.6 80184.0 83492.6 85735.0 11548.1 12743.6 12818.9 12916.0 12948.8 35781.0 36212.6 36358.5 36530.6 37283.3 45557.8 46329.8 46343.8 47181.8 68043.5 18889.4 19285.7 19348.8 19630.7 19640.7 21532.2 21795.2 22107.8 22494.0 22554.2 18476.8 19333.7 19695.8 19813.1 19967.6 18742.7 19377.3 19443.5 19517.2 19743.8 18234.1 18285.1 18293.3 18707.7 18801.4 12922.5 12947.4 13116.0 13354.2 13548.2 13413.5 13878.0 14207.8 14400.9 14723.4 03:19:22 INFO - PID 3586 | -------- Summary: end -------- 03:19:22 INFO - PID 3586 | 03:19:23 INFO - TEST-INFO | 3586: exit 0 03:19:23 INFO - TEST-OK | dromaeo_css | took 1116441ms 03:19:23 INFO - TEST-START | kraken 03:19:23 INFO - Initialising browser for kraken test... 03:19:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45926/getInfo.html -profile /tmp/tmpVq91pt/profile 03:19:23 INFO - TEST-INFO | started process 3963 (/builds/slave/test/build/application/firefox/firefox http://localhost:45926/getInfo.html) 03:19:29 INFO - TEST-INFO | 3963: exit 0 03:19:29 INFO - Browser initialized. 03:19:29 INFO - Running cycle 1/1 for kraken test... 03:19:29 INFO - TEST-INFO | started process 4191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVq91pt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:30 INFO - PID 4191 | 03:19:30 INFO - PID 4191 | (/builds/slave/test/build/application/firefox/firefox:4245): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:30 INFO - PID 4191 | 03:19:40 INFO - PID 4191 | RSS: Main: 173785088 03:19:40 INFO - PID 4191 | 03:19:43 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45926/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:44 INFO - PID 4191 | RSS: Main: 178581504 03:19:44 INFO - PID 4191 | 03:19:47 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45926/tests/kraken/driver.html?testName=audio-dft) 03:19:48 INFO - PID 4191 | RSS: Main: 179228672 03:19:48 INFO - PID 4191 | 03:19:51 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45926/tests/kraken/driver.html?testName=audio-fft) 03:19:51 INFO - PID 4191 | RSS: Main: 174231552 03:19:51 INFO - PID 4191 | 03:19:53 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45926/tests/kraken/driver.html?testName=audio-oscillator) 03:19:54 INFO - PID 4191 | RSS: Main: 175702016 03:19:54 INFO - PID 4191 | 03:19:56 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:57 INFO - PID 4191 | RSS: Main: 175591424 03:19:57 INFO - PID 4191 | 03:20:00 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45926/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:01 INFO - PID 4191 | RSS: Main: 177721344 03:20:01 INFO - PID 4191 | 03:20:04 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45926/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:05 INFO - PID 4191 | RSS: Main: 176525312 03:20:05 INFO - PID 4191 | 03:20:08 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45926/tests/kraken/driver.html?testName=json-parse-financial) 03:20:08 INFO - PID 4191 | RSS: Main: 177725440 03:20:08 INFO - PID 4191 | 03:20:10 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:11 INFO - PID 4191 | RSS: Main: 177664000 03:20:11 INFO - PID 4191 | 03:20:13 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:13 INFO - PID 4191 | RSS: Main: 174886912 03:20:13 INFO - PID 4191 | 03:20:16 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:16 INFO - PID 4191 | RSS: Main: 175112192 03:20:16 INFO - PID 4191 | 03:20:19 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:20 INFO - PID 4191 | RSS: Main: 175624192 03:20:20 INFO - PID 4191 | 03:20:23 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:24 INFO - PID 4191 | RSS: Main: 175771648 03:20:24 INFO - PID 4191 | 03:20:25 INFO - PID 4191 | Cycle 1(1): loaded http://localhost:45926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45926/tests/kraken/driver.html?testName=ai-astar) 03:20:26 INFO - PID 4191 | RSS: Main: 176771072 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | __start_tp_report 03:20:26 INFO - PID 4191 | _x_x_mozilla_page_load 03:20:26 INFO - PID 4191 | _x_x_mozilla_page_load_details 03:20:26 INFO - PID 4191 | |i|pagename|runs| 03:20:26 INFO - PID 4191 | |0;ai-astar;102;109;112;109;112;119;109;99;109;113 03:20:26 INFO - PID 4191 | |1;audio-beat-detection;156;120;145;186;125;150;148;123;178;120 03:20:26 INFO - PID 4191 | |2;audio-dft;163;162;163;165;163;165;167;165;168;163 03:20:26 INFO - PID 4191 | |3;audio-fft;77;83;73;161;80;76;77;83;96;74 03:20:26 INFO - PID 4191 | |4;audio-oscillator;78;78;141;86;81;79;132;89;78;130 03:20:26 INFO - PID 4191 | |5;imaging-gaussian-blur;113;123;114;114;114;115;116;117;117;117 03:20:26 INFO - PID 4191 | |6;imaging-darkroom;150;157;153;150;151;149;150;152;150;152 03:20:26 INFO - PID 4191 | |7;imaging-desaturate;94;94;99;94;94;95;96;94;94;94 03:20:26 INFO - PID 4191 | |8;json-parse-financial;56;57;56;56;57;56;57;57;55;56 03:20:26 INFO - PID 4191 | |9;json-stringify-tinderbox;54;54;54;58;62;58;53;53;54;53 03:20:26 INFO - PID 4191 | |10;stanford-crypto-aes;79;101;81;81;88;81;80;89;80;82 03:20:26 INFO - PID 4191 | |11;stanford-crypto-ccm;132;142;136;134;126;129;130;138;128;184 03:20:26 INFO - PID 4191 | |12;stanford-crypto-pbkdf2;183;185;179;183;190;190;190;177;183;178 03:20:26 INFO - PID 4191 | |13;stanford-crypto-sha256-iterative;68;67;78;67;66;68;69;75;72;69 03:20:26 INFO - PID 4191 | __end_tp_report 03:20:26 INFO - PID 4191 | __start_cc_report 03:20:26 INFO - PID 4191 | _x_x_mozilla_cycle_collect,945 03:20:26 INFO - PID 4191 | __end_cc_report 03:20:26 INFO - PID 4191 | __startTimestamp1501496426164__endTimestamp 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | ------- Summary: start ------- 03:20:26 INFO - PID 4191 | Number of tests: 14 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#0] ai-astar Cycles:10 Average:109.30 Median:112.00 stddev:5.60 (5.0%) stddev-sans-first:5.28 03:20:26 INFO - PID 4191 | Values: 102.0 109.0 112.0 109.0 112.0 119.0 109.0 99.0 109.0 113.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:149.00 stddev:23.71 (15.9%) stddev-sans-first:24.82 03:20:26 INFO - PID 4191 | Values: 156.0 120.0 145.0 186.0 125.0 150.0 148.0 123.0 178.0 120.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:1.96 (1.2%) stddev-sans-first:2.01 03:20:26 INFO - PID 4191 | Values: 163.0 162.0 163.0 165.0 163.0 165.0 167.0 165.0 168.0 163.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#3] audio-fft Cycles:10 Average:88.00 Median:78.50 stddev:26.49 (33.7%) stddev-sans-first:27.79 03:20:26 INFO - PID 4191 | Values: 77.0 83.0 73.0 161.0 80.0 76.0 77.0 83.0 96.0 74.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:78.50 stddev:26.03 (33.2%) stddev-sans-first:26.66 03:20:26 INFO - PID 4191 | Values: 78.0 78.0 141.0 86.0 81.0 79.0 132.0 89.0 78.0 130.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.50 stddev:2.87 (2.5%) stddev-sans-first:2.83 03:20:26 INFO - PID 4191 | Values: 113.0 123.0 114.0 114.0 114.0 115.0 116.0 117.0 117.0 117.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:2.32 (1.5%) stddev-sans-first:2.40 03:20:26 INFO - PID 4191 | Values: 150.0 157.0 153.0 150.0 151.0 149.0 150.0 152.0 150.0 152.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 03:20:26 INFO - PID 4191 | Values: 94.0 94.0 99.0 94.0 94.0 95.0 96.0 94.0 94.0 94.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:0.67 (1.2%) stddev-sans-first:0.71 03:20:26 INFO - PID 4191 | Values: 56.0 57.0 56.0 56.0 57.0 56.0 57.0 57.0 55.0 56.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:54.00 stddev:3.02 (5.6%) stddev-sans-first:3.17 03:20:26 INFO - PID 4191 | Values: 54.0 54.0 54.0 58.0 62.0 58.0 53.0 53.0 54.0 53.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.00 stddev:6.81 (8.4%) stddev-sans-first:6.96 03:20:26 INFO - PID 4191 | Values: 79.0 101.0 81.0 81.0 88.0 81.0 80.0 89.0 80.0 82.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:135.00 stddev:16.92 (12.5%) stddev-sans-first:17.81 03:20:26 INFO - PID 4191 | Values: 132.0 142.0 136.0 134.0 126.0 129.0 130.0 138.0 128.0 184.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:184.00 stddev:4.96 (2.7%) stddev-sans-first:5.25 03:20:26 INFO - PID 4191 | Values: 183.0 185.0 179.0 183.0 190.0 190.0 190.0 177.0 183.0 178.0 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.00 stddev:3.90 (5.7%) stddev-sans-first:4.08 03:20:26 INFO - PID 4191 | Values: 68.0 67.0 78.0 67.0 66.0 68.0 69.0 75.0 72.0 69.0 03:20:26 INFO - PID 4191 | -------- Summary: end -------- 03:20:26 INFO - PID 4191 | 03:20:26 INFO - PID 4191 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:20:26 INFO - TEST-INFO | 4191: exit 0 03:20:26 INFO - TEST-OK | kraken | took 63329ms 03:20:26 INFO - SUITE-END | took 1179s 03:20:27 INFO - Completed test suite (00:19:40) 03:20:27 INFO - javascript benchmark 03:20:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8492.463359990179, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.9687103128963, 3157.621085469744, 3159.8420078996046, 3176.380605781872, 3190.601174853142, 6146.877062458754, 6151.569390142692, 6180.320164781876, 6208.0, 6340.017297318911, 6250.9062364064575, 6295.370462953714, 6315.652639104847, 6336.7465301388, 6349.809505714825, 5563.693996830173, 5635.267415236024, 5665.716714164296, 5748.655080695151, 5814.534837213034, 5640.689762063085, 5686.09022556391, 5781.046127388976, 5794.623349482291, 5804.129380592903, 5662.66024038559, 5675.772969081232, 5701.600887937846, 5767.711614419262, 5778.162166485857, 5547.528460080898, 5654.773809047633, 5721.4850663440075, 5734.8279551613105, 5779.190913272145, 5614.214010038598, 5618.91571626426, 5679.886402271973, 5706.229658996065, 5707.74315155819, 6187.102870083858, 6219.378062193789, 6227.221597300338, 6235.314115447297, 6274.937250627481, 6681.565698229648, 6691.899621505681, 6728.562643428161, 6795.898061529081, 6800.727970881158, 6595.835104122388, 6738.427233685143, 6758.9324106758795, 6771.661416929134, 6870.381665650066, 6161.322254551996, 6222.284437289679, 6223.502119830448, 6224.502039836802, 6226.937730622726, 6822.863542729117, 6853.828654283583, 6856.828579285558, 6857.588544687235, 6879.380855723009, 6575.342465753482, 6579.934200657932, 6580.5064620152725, 6580.967095164589, 6584.473242140617, 6647.302033286435, 6654.301298363699, 6670.199576050905, 6686.5653732507235, 6690.598564086073, 6613.3056029117215, 6630.071789949411, 6641.335866413417, 6651.102101216274, 6663.566868153554, 6683.198016237985, 6697.497687673444, 6771.8984215236815, 6774.559653622498, 6793.966030169818, 5306.336707911511, 5346.732663366816, 5378.838634840961, 5448.618596698193, 5450.727463626803, 4610.53894610543, 4620.861374158781, 4630.259158534618, 4634.976825115853, 4726.149293127201, 5817.301923769175, 5818.0, 5833.88332233353, 5838.2702162229725, 5853.0, 6781.25406205317, 6796.76211332601, 6799.422049125879, 6807.455403567802, 6812.318768123148, 5768.826935191951, 5780.913286300709, 5861.0915308127305, 5888.234529511136, 5891.175235467038, 5816.272965879265, 5855.882882342415, 5856.912146317809, 5858.794942177004, 5928.496077833346, 6469.385408386196, 6470.967645161838, 6545.0, 6549.279579246279, 6551.279359270477, 6254.749810007549, 6717.731290748316, 6729.259781423942, 6793.830154245986, 6833.58998460094, 6443.548951573345, 6488.318726533646, 6577.440917522064, 6589.242237142598, 6592.868142637216, 6458.321876203119, 6538.444232240313, 6553.541252112306, 6575.4410875076155, 6689.933100668931, 6677.866442671022, 6693.1298931138645, 6696.062551242927, 6704.027915952062, 6704.061431399706, 6397.840053998687, 6456.160699109086, 6478.352164783484, 6487.643179625166, 6490.286068532552, 6457.0, 6460.547761656639, 6482.513811464065, 6496.0255961606135, 6501.349865013461, 5595.244641973281, 6356.936430635635, 6380.106785050004, 6420.972644376878, 6517.055027020961, 6500.772472963424, 6528.151340325728, 6543.083968244355, 6640.966795165993, 6657.167854018247, 6220.813375598739, 6300.2754683212015, 6301.275353334242, 6338.556301058881, 6413.134226879311], "value": 6097.578805479952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.588601585223, 877.2981614708234, 899.4423457456378, 901.3059943843239, 1187.1333926233854, 39718.602813971855, 43354.349684754714, 43368.566314336844, 43390.349144762855, 43499.78250108753, 43088.3536746949, 43413.56586434135, 43444.348334775, 43517.34723979143, 43551.34672979908, 7268.491205615609, 7746.92253077469, 7879.1726868678825, 7884.408669349793, 7885.8028549286155, 7738.651760670783, 7863.292303692667, 7865.606719663994, 7870.724524641639, 7871.134175240719, 7803.726869559567, 7828.725994590191, 7835.882461763078, 7873.370130389555, 7882.093559240675, 7821.76534703957, 7836.098848632423, 7848.13670496245, 7848.136704962507, 7856.057273127204, 7668.501547399401, 7741.458097933147, 7763.883541746822, 7766.766996990099, 7791.22087791222, 38683.22633547313, 38971.0, 39128.217435651415, 39136.41295380572, 39200.60799392027, 3511.0695665648623, 3535.398982173011, 3538.3630946429635, 3547.1486843157713, 3547.2728090741334, 30871.073867784, 30931.226719332197, 30998.535021974687, 31006.534901976487, 31072.0, 4591.51789062147, 4607.35497030416, 4664.067186562701, 4691.7654117294, 4754.286856971447, 186144.0, 186210.0, 186426.0, 186656.99999999863, 187294.0, 49584.256236156485, 49846.0, 49924.50075499198, 50093.24860127101, 50153.74923125361, 51913.0, 51967.22049169266, 52089.47910520846, 52416.0, 52416.21375679368, 14977.475788347356, 15321.004134731207, 16402.179891005402, 16650.0, 16682.332706691595, 13552.932235338958, 13689.520866769615, 13721.519746808814, 13738.931305343409, 13739.931300343434, 14675.633109172357, 14779.556613301618, 14832.925835370754, 14853.405863765329, 14941.477048303475, 5913.556483263773, 5935.762569497172, 5976.282846058501, 6000.729967151488, 6003.849903752441, 972.8297547929084, 986.063239922077, 996.7059717383389, 1003.6988903328972, 1005.8541511480794, 22981.195658151886, 23350.883245584002, 23578.646320305208, 23642.81785910732, 24084.51830963371, 1064.302881612545, 1079.7138758229075, 1087.543231842628, 1090.0571006079842, 1101.6970333158445, 11368.204225704287, 11732.178747487595, 11934.104942129376, 12015.0, 12124.090693198046, 222316.0, 223193.0, 224520.0, 224980.0, 225349.0, 52053.7397313011, 52424.737876311134, 52506.0, 52580.47419525832, 52655.0, 1461.9269036548342, 1484.317214081513, 1509.645233370157, 1511.3727802961866, 1520.695860827839, 21876.343709688736, 21895.78104219001, 21955.67066493972, 22000.229991950204, 22511.887440562692, 36598.268034638626, 37000.25999480049, 37047.81476092602, 37338.0, 51977.0, 211731.0, 211995.0, 213549.0, 214013.0, 214418.0, 35431.46852797262, 35967.82016089903, 36277.63722362848, 36311.455328170625, 37304.25391492209, 47508.7624561875, 47817.52182478131, 47830.0, 47844.28233576569, 48235.276470852266, 27257.31856703598, 27851.721482785724, 28702.712972870006, 28825.855870720512, 29080.7091929078, 26380.8680956594, 28011.0, 28582.42835143327, 28629.427411451237, 28844.0, 37136.0, 37796.811015945845, 37797.62202377941, 37805.81097094497, 37989.620103799716, 31456.52815207728, 33166.502502462965, 33620.663793362735, 33875.0, 34019.4897076549, 23707.52584948326, 24650.383740406633, 24724.752752472246, 24736.25791226266, 24904.62643060392], "value": 17334.878687741122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.569634229814, 567.1804242869056, 568.6616463204394, 572.3046498504316, 581.9796307129251, 19027.714584281246, 22495.662565061517, 23235.186768463107, 23310.41723956902, 23328.416789580268, 26766.5985010225, 27377.589336159974, 27442.45115097697, 27448.17655470339, 27524.0, 7127.28727127287, 7266.091738532684, 7307.050083489139, 7343.559386436831, 7347.963260183692, 6245.0, 6683.799486015403, 6984.5110842241065, 6991.755288564901, 7030.156381234259, 6924.58452492852, 6964.164300283973, 6992.6853291602, 6999.12510936133, 7015.403690686272, 6981.441484681239, 6996.580205187705, 7017.47368947331, 7019.052427922267, 7024.894626580605, 6839.692213850389, 6846.212685541177, 6848.554843935178, 6864.176298844171, 6882.346177113166, 30049.849750751324, 31259.531107033185, 32038.519422208687, 32185.51721724176, 32302.192445188823, 1954.7654281486314, 1986.6523358412364, 1996.8502362322738, 1997.3808119482862, 1997.680371140625, 19896.502587435287, 20679.172833086657, 20721.0, 20748.377548673565, 20783.792162078487, 2316.9073237070497, 2457.7910877575428, 2544.9872750636314, 2557.373443506353, 2567.101514469939, 143257.0, 145950.0, 146106.0, 146351.0, 146510.0, 20207.69688454674, 21577.67633485499, 21791.23730669419, 21969.825733110658, 22596.98986628301, 44010.55989440065, 44082.33876491855, 44125.0, 44191.33712994308, 44201.0, 10517.9474102629, 10520.421376824195, 10715.749692564494, 10730.678079657622, 10914.890851091546, 8624.490714125002, 8702.869456958151, 8710.825783484295, 8904.688335908211, 9438.339316247933, 9312.580933857993, 9390.85913711295, 9452.109578084273, 9564.234861211087, 9604.127195197008, 2891.181098429057, 2899.767179271949, 2900.347421830071, 2920.941581168365, 2960.3883262419813, 970.4322971062007, 972.557486343726, 974.8976357482504, 1008.8133695266399, 1021.5454122915231, 19529.414117576496, 19742.90128549348, 19804.20783168686, 20205.494862628257, 23202.41993950131, 1015.2334987084852, 1025.9025392587841, 1035.8378330703795, 1049.9895001050045, 1050.9054185123375, 11011.229213955106, 11035.613753518588, 11290.322580645023, 11314.0, 11362.48868800906, 527332.0, 528757.0, 536040.0, 536909.0, 537440.0, 117571.41214293875, 120106.39946800384, 121280.39359803144, 121915.39042304731, 122504.0, 1250.3435696259537, 1259.3262604506729, 1285.1068507387463, 1293.7606542789615, 1303.67408147963, 16854.0, 18010.0, 18206.45380638583, 18496.537586559905, 18849.434516964513, 53586.46413535815, 56441.0, 58099.70950145222, 58793.70603146957, 60011.39988600058, 71871.64064179646, 72444.0, 72463.27536724565, 72768.27231727615, 73215.63392183006, 12315.876841231473, 12897.41961611711, 14283.714325713636, 14438.639034024234, 14833.0, 23310.76689233154, 23395.298141055795, 23511.41221469477, 23661.64507532354, 23687.763122369244, 18138.274469021093, 18271.908640456713, 18283.360082397052, 18591.90704046471, 18685.90657046706, 14254.572362829133, 15221.162836044125, 15306.540803775904, 15366.308516116578, 15683.529494115195, 18737.531561711065, 18874.24503019864, 19068.141933613297, 19081.0, 20319.49201269921, 14970.101793892401, 14992.400303988155, 15070.773938390714, 15118.470853520073, 15136.772948405562, 17875.910620446815, 18417.723734143732, 18793.342233022326, 18796.530086747392, 18815.435536933914], "value": 12651.622583922446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.717977814548, 1423.7152569486104, 1426.721789251095, 1436.3105709259562, 1439.978400323995, 13691.110077844933, 13943.16341019537, 14327.212003339811, 14360.0, 14418.0, 12826.166299190547, 12962.351882405888, 12971.156874803155, 12972.481100755982, 13005.219686818797, 2643.8149329546986, 2705.878235479408, 2706.5534186859145, 2707.2284398946304, 2708.377073273148, 2590.0546300600336, 2677.611746296786, 2754.297654098202, 2755.256080858167, 2759.0481283957, 2516.7860731837723, 2528.633348164515, 2557.3734435063434, 2560.8207425480223, 2561.5773397389407, 2580.071174377232, 2618.4763047390597, 2627.737226277376, 2633.7102918679025, 2679.5712685970248, 2494.5135698538793, 2541.4154744408706, 2565.076572433922, 2573.1122762646855, 2607.035396903139, 14191.148531088167, 14268.215248161347, 14273.214973176471, 14295.78556321656, 14296.285185740671, 7316.926830731678, 7547.358474529671, 7577.583232922187, 7610.657520411595, 7611.80970475737, 4784.760761961888, 5017.874553136165, 5203.843884683465, 5204.3234379530795, 5214.139666954986, 1593.3228377939329, 1637.6806522728073, 1682.6802907447668, 1688.8817782755211, 1691.4671878358279, 22606.32181034555, 22941.31176064704, 22965.54068918629, 23102.0, 23107.653385199068, 6181.598196117238, 6359.682015899187, 6368.42684158428, 6537.934620653828, 6582.637954912526, 15910.602234943988, 15990.280437380346, 16033.358665653477, 16091.114988675501, 16092.919535402249, 7357.2642735726, 7517.473776835678, 7521.398288136936, 7521.7367392142105, 7524.548527088392, 6635.5023373247195, 6819.829504262334, 6869.7595584154315, 6958.47811414146, 6989.47578931572, 5034.270030845581, 5050.797968081236, 5059.392872855281, 5149.613778966593, 5168.9741551292, 1369.452219112363, 1451.7459444597364, 1457.453454954392, 1462.8098347214793, 1528.740114180592, 825.4304529874488, 827.5489858027389, 845.5814371885956, 864.446754077391, 888.9466632002101, 7173.354398104091, 7263.382612477999, 7474.40204783616, 7523.962380188064, 7529.774106776806, 920.9907900921039, 941.1247539787926, 966.4539535162611, 968.4576637083256, 983.1544871410581, 4002.539707933625, 4280.101178752435, 4954.355933728592, 4991.625628077836, 5012.8496145115705, 19113.235470581298, 19570.60858782845, 19601.705974410394, 19610.60778784445, 19643.508912277306, 18014.729779053323, 18905.905470472833, 19056.52358691044, 19205.32781352646, 19252.326168584033, 10656.786864262827, 10855.457227138611, 10862.78274434507, 10914.617988370368, 10916.617918372818, 7199.42476506235, 7376.852462950818, 7728.304452599293, 7800.492967957065, 7979.082405523439, 15635.374585016472, 16458.09480478585, 16504.33982640729, 16827.158642067603, 17314.0, 16415.9179204108, 16854.1572921351, 17106.374894385015, 17249.31002759926, 17264.48206553755, 11272.605458808903, 11376.715582110513, 11500.424978750862, 11640.825387619023, 11689.415529223335, 13093.41079651437, 13246.271455070064, 13252.20486770797, 13256.801147982595, 13271.203727776365, 9783.706488805346, 9998.800023999334, 10206.23453240995, 10343.63797267092, 10401.27191096616, 9629.229661626912, 10236.897631023594, 10314.174866010851, 10325.483725813829, 10480.213983951387, 8601.440906341068, 8764.561771911507, 8769.956150219208, 8771.56142192875, 8777.253933415732, 5945.0, 6101.877962440638, 6365.427111559982, 6391.6804159792755, 6445.709943052668, 6299.685015749103, 6420.229572451149, 6583.0, 6742.325767423218, 6851.212110607344], "value": 6210.28905188551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.83894331491024, 509.5668681620623, 533.3413234655203, 533.8505218538809, 534.3614380814928, 6151.4463698267145, 6154.661493617855, 6238.157848690425, 6276.592021518603, 6287.528435367343, 5999.940000599992, 6031.24609423822, 6111.480524155441, 6152.723127459264, 6187.102870083835, 4942.209246520558, 4964.851054468371, 4987.62592805541, 5005.674631148972, 5006.874828129289, 4901.68139070961, 4926.729029903354, 4978.975105124469, 4986.030517945409, 5006.173981293082, 4669.719816811003, 4802.759862006903, 4850.393700787402, 4893.9934626803015, 4907.4356449008465, 4825.20384136617, 4855.198892182803, 4860.816165411661, 4880.194767863299, 4931.112399768041, 4276.764777937212, 4326.394304797331, 4332.155229730204, 4375.365571992043, 4407.559244075567, 5916.556258280646, 5997.490213331872, 6026.564858030924, 6084.421979911901, 6097.237845269341, 5645.15322701594, 5650.29371328584, 5671.404502527258, 5682.488576028178, 5692.6299790513485, 6372.426481616677, 6408.871822563523, 6433.549651524395, 6437.549371543993, 6501.837454063639, 4777.235642297251, 4777.880552986203, 4778.665493415462, 4805.543473370024, 4858.271259311096, 6801.0, 6830.59016459014, 6892.517523773338, 6896.620685862225, 6919.584824910521, 4894.437139728977, 4928.137575924199, 4950.925736113961, 4976.2286845539, 4983.526564976321, 5051.621128415383, 5059.392872855207, 5060.468650791614, 5078.0, 5084.745762711849, 5662.8301150965535, 5676.148577713376, 5676.262085928803, 5705.800296989585, 5724.484796368263, 6456.257530383972, 6476.708548115346, 6494.642794646245, 6516.674166291761, 6558.573692709959, 1661.4932445604206, 1722.5349155727883, 1744.0669241955493, 1749.7025505664067, 1759.2347328911965, 1162.7616338650557, 1186.9287842729464, 1204.8433703618473, 1219.7375716133758, 1243.6890777305673, 5544.445555444504, 5553.77784888608, 5580.079286917694, 5586.804461843816, 5633.943660563424, 6448.355164483514, 6462.4183823456115, 6471.805845824632, 6506.512011599149, 6622.966885165543, 5577.358603760619, 5634.32388113429, 5744.942550574441, 5761.53907687384, 5837.562182836219, 3548.4854696068924, 3570.4465807799834, 3595.424732042861, 3604.6575575320303, 3623.384024715752, 6441.645709486023, 6448.516361272923, 6453.225612926385, 6466.482681385478, 6476.805695829133, 6703.631300278434, 6734.292899245509, 6802.455803535705, 6833.692483838239, 6863.38229559342, 6335.65153916539, 6345.270293916259, 6435.871282574416, 6441.0, 6508.0, 6659.300773418721, 6664.034109937483, 6685.930251159791, 6697.330266973264, 6740.528163028541, 6623.0, 6636.336366363325, 6637.4690024798865, 6654.800355989328, 6696.229933557508, 6416.165898433173, 6507.479401647952, 6515.250746164252, 6520.250171230369, 6535.836604084936, 4962.950370496394, 4976.800927962841, 4983.725895075806, 4987.102321582005, 5009.597312752435, 6638.800835974928, 6682.264950855305, 6687.431568316553, 6768.255491895986, 6797.864042719217, 6470.352964703492, 6492.448141907991, 6505.837354066186, 6528.21661400635, 6565.409113179837, 6445.6454894981225, 6471.967640161769, 6477.708503117466, 6514.9348506514325, 6568.0, 6082.482988945989, 6241.21984751906, 6292.653904035322, 6323.430891219812, 6398.264199617103, 6207.410296021871, 6434.2922278548385, 6535.5425120241125, 6548.8035358939305, 6565.606063636197, 6230.657313847782, 6271.937280627318, 6291.339409361951, 6318.747250109944, 6374.310807636073], "value": 5005.642581708123, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.4385671242053, 899.6896070855555, 925.2644147902417, 927.5315965437453, 928.6981730937447, 17678.469645910627, 18575.535611609717, 18596.163172657212, 18610.81389186108, 18677.533061673465, 17427.825721742778, 17575.38486152985, 20151.596968060665, 21727.0, 21885.234016809416, 1003.7202566727408, 1038.9480525973709, 1042.3329069395593, 1043.0560342889696, 1043.243648354944, 985.1626117799884, 1025.6717850287912, 1040.885502594714, 1040.9375437473775, 1046.4192373232852, 1074.8119079161115, 1077.0737166037202, 1077.6982444915398, 1081.2377274021796, 1083.664064140119, 1064.3720205079003, 1072.2922870905204, 1072.5924148823397, 1073.0825144501455, 1073.3238060022136, 784.8861915022347, 790.9011373578303, 791.1020991175058, 797.4059325802315, 797.9760607181794, 18927.526811829677, 19178.520536986547, 19306.4208073758, 19416.708749368772, 19687.31094411703, 20583.279585214445, 20614.896925515277, 21045.684314735292, 21085.8945705272, 21175.68236476454, 15724.842751572452, 15922.442714504938, 16023.91988040064, 16114.0, 16116.83883161165, 3544.220271540257, 3548.2193917338145, 3553.0051585556084, 3575.0704816747575, 3578.141246100943, 121860.0, 124790.0, 127768.80577985532, 129004.0, 130752.34623826915, 15632.2183890805, 15782.289796958934, 15929.203539822962, 16046.67906641884, 16134.112623805804, 29677.0, 30164.396712065634, 30269.848650756605, 30320.241993949887, 30341.544876826865, 8085.878711819328, 8266.793330166674, 8298.875516867252, 8304.58477076156, 8305.709300174465, 4269.146170765859, 4327.675424343187, 4365.257906155961, 4368.737875727466, 4370.628496577827, 5118.053160165381, 5223.608229382811, 5263.473652634782, 5297.708626025606, 5306.681599104066, 935.209747763139, 957.8371676814958, 971.4996776660025, 975.8048390321964, 978.9021097890296, 654.4044919123575, 668.4986260304771, 686.4165459359505, 711.2567367101392, 718.5509056839476, 11072.778544429066, 11466.713332166762, 12141.69645758863, 12777.488900443877, 13453.192808431526, 635.5392340553154, 674.3357792574409, 698.783377153074, 699.9615021173782, 706.1138271469273, 5291.259223708684, 5474.835754927359, 5659.632123912015, 5725.971370143123, 5978.850528736816, 98691.0, 99608.50195748975, 102060.48969755252, 102355.0, 104251.0, 84681.0, 85195.0, 90714.0, 90936.0, 92798.0, 76025.0, 77471.61264193755, 80184.0, 83492.58253708693, 85735.0, 11548.133889958455, 12743.553975610808, 12818.935905320413, 12916.031297652902, 12948.8057679133, 35781.0, 36212.637373212994, 36358.454623181206, 36530.634693652726, 37283.254334912606, 45557.77221114006, 46329.768351158025, 46343.76828115838, 47181.76409117933, 68043.49346898487, 18889.433317000512, 19285.710714339017, 19348.8065119347, 19630.705539416635, 19640.705389419454, 21532.246371376925, 21795.23716669909, 22107.77892221057, 22494.0, 22554.210602628827, 18476.815231848046, 19333.709994349814, 19695.803041969397, 19813.108410121866, 19967.60064798725, 18742.718859217395, 19377.321793737152, 19443.51391215231, 19517.219311227393, 19743.802561974197, 18234.088295585432, 18285.085745712397, 18293.26826926908, 18707.71938420952, 18801.435956921316, 12922.483100675867, 12947.352632368156, 13116.01629877782, 13354.198748075147, 13548.187108773505, 13413.463461461432, 13878.0, 14207.792337651415, 14400.927995359956, 14723.411063557765], "value": 9023.549340490357, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 112.0, 109.0, 112.0, 119.0, 109.0, 99.0, 109.0, 113.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 120.0, 145.0, 186.0, 125.0, 150.0, 148.0, 123.0, 178.0, 120.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 165.0, 163.0, 165.0, 167.0, 165.0, 168.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 73.0, 161.0, 80.0, 76.0, 77.0, 83.0, 96.0, 74.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 141.0, 86.0, 81.0, 79.0, 132.0, 89.0, 78.0, 130.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 123.0, 114.0, 114.0, 114.0, 115.0, 116.0, 117.0, 117.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 157.0, 153.0, 150.0, 151.0, 149.0, 150.0, 152.0, 150.0, 152.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 58.0, 62.0, 58.0, 53.0, 53.0, 54.0, 53.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 101.0, 81.0, 81.0, 88.0, 81.0, 80.0, 89.0, 80.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 142.0, 136.0, 134.0, 126.0, 129.0, 130.0, 138.0, 128.0, 184.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 179.0, 183.0, 190.0, 190.0, 190.0, 177.0, 183.0, 178.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 78.0, 67.0, 66.0, 68.0, 69.0, 75.0, 72.0, 69.0], "value": 69.9, "unit": "score"}]}]} 03:20:27 INFO - Return code: 0 03:20:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:27 INFO - # TBPL SUCCESS # 03:20:27 INFO - Running post-action listener: _package_coverage_data 03:20:27 INFO - Running post-action listener: _resource_record_post_action 03:20:27 INFO - [mozharness: 2017-07-31 10:20:27.461298Z] Finished run-tests step (success) 03:20:27 INFO - Running post-run listener: _resource_record_post_run 03:20:27 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 6066176; Write bytes: 442146816; Read time: 3408; Write time: 302228 03:20:27 INFO - TinderboxPrint: CPU usage
13.2% 03:20:27 INFO - TinderboxPrint: I/O read bytes / time
6,066,176 / 3,408 03:20:27 INFO - TinderboxPrint: I/O write bytes / time
442,146,816 / 302,228 03:20:27 INFO - TinderboxPrint: CPU idle
8,299.1 (86.8%) 03:20:27 INFO - TinderboxPrint: CPU user
1,205.5 (12.6%) 03:20:27 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116375552; Read time: 52; Write time: 79588 03:20:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:20:27 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 3825664; Write bytes: 325378048; Read time: 3088; Write time: 222564 03:20:28 INFO - Running post-run listener: _upload_blobber_files 03:20:28 INFO - Blob upload gear active. 03:20:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:28 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 03:20:28 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'] 03:20:28 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 03:20:28 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:29 INFO - (blobuploader) - INFO - Done attempting. 03:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:30 INFO - (blobuploader) - INFO - Done attempting. 03:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:37 INFO - (blobuploader) - INFO - Done attempting. 03:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:38 INFO - (blobuploader) - INFO - Done attempting. 03:20:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:38 INFO - Return code: 0 03:20:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffaed05601114da92e362f26f1ed905e1cf715d5bf5f841566b26d53a1e714f86b3fab710eff2c6fe591d2102b4cff11e4332010315fc10c942a284216739b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1f34b111858e28ffcec55f7241c5e84d440abda171ae65f704bb797e449966264248a9aaa0bc9f15b7a45da093619174ac81f23a17c3e448cbb90990260a7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25680d8431ca94187ba05dc914b16a569fea28aa1db9395f8962138b613c1ebf752ad4314d00991dd194d28bea6e40addaf3d7c021e4eb84b6a51c06445a2ed8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99c6cbe77949add5e0546a2b180ef54542d343c40d28d4b75ff68b28ef8bc7f1e971033d27f182245d64593fe137f8b12837a7b2052ad90e832a8bd35212efc"} 03:20:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:38 INFO - Contents: 03:20:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffaed05601114da92e362f26f1ed905e1cf715d5bf5f841566b26d53a1e714f86b3fab710eff2c6fe591d2102b4cff11e4332010315fc10c942a284216739b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1f34b111858e28ffcec55f7241c5e84d440abda171ae65f704bb797e449966264248a9aaa0bc9f15b7a45da093619174ac81f23a17c3e448cbb90990260a7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25680d8431ca94187ba05dc914b16a569fea28aa1db9395f8962138b613c1ebf752ad4314d00991dd194d28bea6e40addaf3d7c021e4eb84b6a51c06445a2ed8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99c6cbe77949add5e0546a2b180ef54542d343c40d28d4b75ff68b28ef8bc7f1e971033d27f182245d64593fe137f8b12837a7b2052ad90e832a8bd35212efc"} 03:20:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:38 INFO - Copying logs to upload dir... 03:20:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.145876 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-07-31 03:20:37.976272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:20:37.979308) ========= 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=a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794 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/1ffaed05601114da92e362f26f1ed905e1cf715d5bf5f841566b26d53a1e714f86b3fab710eff2c6fe591d2102b4cff11e4332010315fc10c942a284216739b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1f34b111858e28ffcec55f7241c5e84d440abda171ae65f704bb797e449966264248a9aaa0bc9f15b7a45da093619174ac81f23a17c3e448cbb90990260a7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25680d8431ca94187ba05dc914b16a569fea28aa1db9395f8962138b613c1ebf752ad4314d00991dd194d28bea6e40addaf3d7c021e4eb84b6a51c06445a2ed8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99c6cbe77949add5e0546a2b180ef54542d343c40d28d4b75ff68b28ef8bc7f1e971033d27f182245d64593fe137f8b12837a7b2052ad90e832a8bd35212efc"} build_url:https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffaed05601114da92e362f26f1ed905e1cf715d5bf5f841566b26d53a1e714f86b3fab710eff2c6fe591d2102b4cff11e4332010315fc10c942a284216739b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e1f34b111858e28ffcec55f7241c5e84d440abda171ae65f704bb797e449966264248a9aaa0bc9f15b7a45da093619174ac81f23a17c3e448cbb90990260a7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25680d8431ca94187ba05dc914b16a569fea28aa1db9395f8962138b613c1ebf752ad4314d00991dd194d28bea6e40addaf3d7c021e4eb84b6a51c06445a2ed8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99c6cbe77949add5e0546a2b180ef54542d343c40d28d4b75ff68b28ef8bc7f1e971033d27f182245d64593fe137f8b12837a7b2052ad90e832a8bd35212efc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:20:38.006104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:20:38.006448) ========= 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=a0d2d2de893abaa8702a9954000001a7-1501482007.587694-767053794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:20:38.086855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:20:38.090183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:20:38.090468) ========= ========= Total master_lag: 0.26 =========