builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1501495143.34 results: success (0) revision: 26516ba270816a6cc90f5c42a9b66701369a551f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.344474) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.349153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.349476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.372710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.373022) ========= 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=32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 02:59:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-07-31 02:59:03 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.520125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.520426) ========= 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=32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.569771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:03.573108) ========= 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=32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 02:59:03,837 truncating revision to first 12 chars 2017-07-31 02:59:03,837 Setting DEBUG logging. 2017-07-31 02:59:03,837 attempt 1/10 2017-07-31 02:59:03,837 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:04,365 unpacking tar archive at: mozilla-central-26516ba27081/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:04.390806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:04.394106) ========= script_repo_revision: 26516ba270816a6cc90f5c42a9b66701369a551f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:04.395107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:04.395368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 02:59:04.413333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-31 02:59:04.413600) ========= /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=32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:04 INFO - MultiFileLogger online at 20170731 02:59:04 in /builds/slave/test 02:59:04 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:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:04 INFO - {'append_to_log': False, 02:59:04 INFO - 'base_work_dir': '/builds/slave/test', 02:59:04 INFO - 'blob_upload_branch': 'Firefox', 02:59:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:04 INFO - 'branch': 'Firefox', 02:59:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:04 INFO - 'code_coverage': False, 02:59:04 INFO - 'config_files': ('talos/linux_config.py',), 02:59:04 INFO - 'default_actions': ('clobber', 02:59:04 INFO - 'read-buildbot-config', 02:59:04 INFO - 'download-and-extract', 02:59:04 INFO - 'populate-webroot', 02:59:04 INFO - 'create-virtualenv', 02:59:04 INFO - 'install', 02:59:04 INFO - 'setup-mitmproxy', 02:59:04 INFO - 'run-tests'), 02:59:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:04 INFO - 'disable_ccov_upload': False, 02:59:04 INFO - 'download_minidump_stackwalk': True, 02:59:04 INFO - 'download_symbols': 'ondemand', 02:59:04 INFO - 'enable_stylo': False, 02:59:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:04 INFO - 'gecko_profile': False, 02:59:04 INFO - 'gecko_profile_interval': 0, 02:59:04 INFO - 'installer_path': 'installer.exe', 02:59:04 INFO - 'log_level': 'info', 02:59:04 INFO - 'log_name': 'talos', 02:59:04 INFO - 'log_to_console': True, 02:59:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:04 INFO - 'opt_config_files': (), 02:59:04 INFO - 'pip_index': False, 02:59:04 INFO - 'suite': 'dromaeojs-e10s', 02:59:04 INFO - 'system_bits': '32', 02:59:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:04 INFO - 'title': 'talos-linux64-ix-008', 02:59:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:04 INFO - 'use_talos_json': True, 02:59:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:04 INFO - 'work_dir': 'build'} 02:59:04 INFO - [mozharness: 2017-07-31 09:59:04.786187Z] Running clobber step. 02:59:04 INFO - Running pre-action listener: _resource_record_pre_action 02:59:04 INFO - Running main action method: clobber 02:59:04 INFO - rmtree: /builds/slave/test/build 02:59:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:05 INFO - Running post-action listener: _resource_record_post_action 02:59:05 INFO - [mozharness: 2017-07-31 09:59:05.819236Z] Finished clobber step (success) 02:59:05 INFO - [mozharness: 2017-07-31 09:59:05.819339Z] Running read-buildbot-config step. 02:59:05 INFO - Running pre-action listener: _resource_record_pre_action 02:59:05 INFO - Running main action method: read_buildbot_config 02:59:05 INFO - Using buildbot properties: 02:59:05 INFO - { 02:59:05 INFO - "project": "", 02:59:05 INFO - "product": "firefox", 02:59:05 INFO - "who": "archaeopteryx@coole-files.de", 02:59:05 INFO - "installer_path": "public/build/target.tar.bz2", 02:59:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:59:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:59:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:59:05 INFO - "stage_platform": "linux64-stylo", 02:59:05 INFO - "basedir": "/builds/slave/test", 02:59:05 INFO - "buildnumber": 11, 02:59:05 INFO - "platform": "ubuntu64_hw_stylo", 02:59:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:59:05 INFO - "slavebuilddir": "test", 02:59:05 INFO - "taskId": "MCapy6QsSaeWrke0eQunHw", 02:59:05 INFO - "branch": "mozilla-central", 02:59:05 INFO - "script_repo_revision": "production", 02:59:05 INFO - "revision": "26516ba270816a6cc90f5c42a9b66701369a551f", 02:59:05 INFO - "slavename": "talos-linux64-ix-008", 02:59:05 INFO - "repo_path": "mozilla-central" 02:59:05 INFO - } 02:59:05 INFO - Finding installer, test and symbols from parent task. 02:59:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCapy6QsSaeWrke0eQunHw'}, attempt #1 02:59:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MCapy6QsSaeWrke0eQunHw'}, attempt #1 02:59:06 INFO - Task dependencies: L9gn2xeTReiDdJK-FxgWPg 02:59:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg'}, attempt #1 02:59:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 02:59:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.test_packages.json 02:59:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.crashreporter-symbols.zip 02:59:07 INFO - Running post-action listener: _resource_record_post_action 02:59:07 INFO - [mozharness: 2017-07-31 09:59:07.182433Z] Finished read-buildbot-config step (success) 02:59:07 INFO - [mozharness: 2017-07-31 09:59:07.182654Z] Running download-and-extract step. 02:59:07 INFO - Running pre-action listener: _resource_record_pre_action 02:59:07 INFO - Running main action method: download_and_extract 02:59:07 INFO - mkdir: /builds/slave/test/build/tests 02:59:07 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:07 INFO - trying https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.test_packages.json 02:59:07 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:07 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:07 INFO - Downloaded 989 bytes. 02:59:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:07 INFO - Using the following test package requirements: 02:59:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:07 INFO - u'common': [u'target.common.tests.zip'], 02:59:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:07 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:07 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:07 INFO - u'target.web-platform.tests.tar.gz'], 02:59:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:59:07 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:07 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:07 INFO - Fetch https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip into memory 02:59:11 INFO - Content-Length response header: 72389766 02:59:11 INFO - Bytes received: 72389766 02:59:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:59:22 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:22 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:22 INFO - Fetch https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.common.tests.zip into memory 02:59:24 INFO - Content-Length response header: 72389766 02:59:24 INFO - Bytes received: 72389766 02:59:38 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 02:59:38 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 02:59:38 INFO - Fetch https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.talos.tests.zip into memory 02:59:38 INFO - Content-Length response header: 14496686 02:59:38 INFO - Bytes received: 14496686 02:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:39 INFO - trying https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 02:59:39 INFO - Downloading https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:59:39 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 02:59:40 INFO - Downloaded 62292573 bytes. 02:59:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 02:59:40 INFO - mkdir: /builds/slave/test/properties 02:59:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:40 INFO - Contents: 02:59:40 INFO - build_url:https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 02:59:40 INFO - Running post-action listener: _resource_record_post_action 02:59:40 INFO - Running post-action listener: set_extra_try_arguments 02:59:40 INFO - [mozharness: 2017-07-31 09:59:40.343820Z] Finished download-and-extract step (success) 02:59:40 INFO - [mozharness: 2017-07-31 09:59:40.343917Z] Running populate-webroot step. 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: populate_webroot 02:59:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:40 INFO - 'tests': ['damp', 'tps']}, 02:59:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:59:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:59:40 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:40 INFO - 'ts_paint', 02:59:40 INFO - 'tpaint', 02:59:40 INFO - 'sessionrestore', 02:59:40 INFO - 'sessionrestore_many_windows', 02:59:40 INFO - 'sessionrestore_no_auto_restore', 02:59:40 INFO - 'tabpaint']}, 02:59:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:59:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:59:40 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:40 INFO - 'talos_options': ['--mitmproxy', 02:59:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:40 INFO - '--firstNonBlankPaint'], 02:59:40 INFO - 'tests': ['quantum_pageload_google', 02:59:40 INFO - 'quantum_pageload_youtube', 02:59:40 INFO - 'quantum_pageload_amazon', 02:59:40 INFO - 'quantum_pageload_facebook']}, 02:59:40 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:40 INFO - 'talos_options': ['--stylo', 02:59:40 INFO - '--mitmproxy', 02:59:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:40 INFO - '--firstNonBlankPaint'], 02:59:40 INFO - 'tests': ['quantum_pageload_google', 02:59:40 INFO - 'quantum_pageload_youtube', 02:59:40 INFO - 'quantum_pageload_amazon', 02:59:40 INFO - 'quantum_pageload_facebook']}, 02:59:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:40 INFO - 'tsvgr_opacity', 02:59:40 INFO - 'tart', 02:59:40 INFO - 'tscrollx', 02:59:40 INFO - 'cart', 02:59:40 INFO - 'tsvg_static']}, 02:59:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:40 INFO - 'talos_options': ['--stylo', 02:59:40 INFO - '--stylo-threads=1', 02:59:40 INFO - '--mitmproxy', 02:59:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:40 INFO - '--firstNonBlankPaint'], 02:59:40 INFO - 'tests': ['tp6_google', 02:59:40 INFO - 'tp6_youtube', 02:59:40 INFO - 'tp6_amazon', 02:59:40 INFO - 'tp6_facebook']}, 02:59:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:40 INFO - 'talos_options': ['--xperf_path', 02:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:40 INFO - 'tests': ['tp5n']}}} 02:59:40 INFO - Running post-action listener: _resource_record_post_action 02:59:40 INFO - [mozharness: 2017-07-31 09:59:40.352497Z] Finished populate-webroot step (success) 02:59:40 INFO - [mozharness: 2017-07-31 09:59:40.352587Z] Running create-virtualenv step. 02:59:40 INFO - Running pre-action listener: _resource_record_pre_action 02:59:40 INFO - Running main action method: create_virtualenv 02:59:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:40 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 02:59:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:59:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:40 INFO - Using real prefix '/usr' 02:59:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:42 INFO - Installing pip.................done. 02:59:42 INFO - Return code: 0 02:59:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:43 INFO - Reading from file tmpfile_stdout 02:59:43 INFO - Output received: 02:59:43 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) 02:59:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:43 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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:43 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 02:59:43 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 02:59:43 INFO - Using env: {'DISPLAY': ':0', 02:59:43 INFO - 'HOME': '/home/cltbld', 02:59:43 INFO - 'LANG': 'en_US.UTF-8', 02:59:43 INFO - 'LANGUAGE': 'en_US:en', 02:59:43 INFO - 'LOGNAME': 'cltbld', 02:59:43 INFO - 'MAIL': '/var/mail/cltbld', 02:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:43 INFO - 'MOZ_NO_REMOTE': '1', 02:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:43 INFO - 'NO_EM_RESTART': '1', 02:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:43 INFO - 'PWD': '/builds/slave/test', 02:59:43 INFO - 'SHELL': '/bin/bash', 02:59:43 INFO - 'SHLVL': '1', 02:59:43 INFO - 'TERM': 'linux', 02:59:43 INFO - 'TMOUT': '86400', 02:59:43 INFO - 'USER': 'cltbld', 02:59:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:43 INFO - '_': '/tools/buildbot/bin/python'} 02:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:43 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 02:59:43 INFO - Cleaning up... 02:59:43 INFO - Return code: 0 02:59:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:43 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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:43 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 02:59:43 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 02:59:43 INFO - Using env: {'DISPLAY': ':0', 02:59:43 INFO - 'HOME': '/home/cltbld', 02:59:43 INFO - 'LANG': 'en_US.UTF-8', 02:59:43 INFO - 'LANGUAGE': 'en_US:en', 02:59:43 INFO - 'LOGNAME': 'cltbld', 02:59:43 INFO - 'MAIL': '/var/mail/cltbld', 02:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:43 INFO - 'MOZ_NO_REMOTE': '1', 02:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:43 INFO - 'NO_EM_RESTART': '1', 02:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:43 INFO - 'PWD': '/builds/slave/test', 02:59:43 INFO - 'SHELL': '/bin/bash', 02:59:43 INFO - 'SHLVL': '1', 02:59:43 INFO - 'TERM': 'linux', 02:59:43 INFO - 'TMOUT': '86400', 02:59:43 INFO - 'USER': 'cltbld', 02:59:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:43 INFO - '_': '/tools/buildbot/bin/python'} 02:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:43 INFO - Downloading/unpacking psutil>=3.1.1 02:59:43 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 02:59:43 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 02:59:43 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 02:59:43 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 02:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:44 INFO - Installing collected packages: psutil 02:59:44 INFO - Running setup.py install for psutil 02:59:44 INFO - building 'psutil._psutil_linux' extension 02:59:44 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 02:59:45 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 02:59:45 INFO - building 'psutil._psutil_posix' extension 02:59:45 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 02:59:45 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 02:59:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:45 INFO - Successfully installed psutil 02:59:45 INFO - Cleaning up... 02:59:45 INFO - Return code: 0 02:59:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:45 INFO - Using env: {'DISPLAY': ':0', 02:59:45 INFO - 'HOME': '/home/cltbld', 02:59:45 INFO - 'LANG': 'en_US.UTF-8', 02:59:45 INFO - 'LANGUAGE': 'en_US:en', 02:59:45 INFO - 'LOGNAME': 'cltbld', 02:59:45 INFO - 'MAIL': '/var/mail/cltbld', 02:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:45 INFO - 'MOZ_NO_REMOTE': '1', 02:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:45 INFO - 'NO_EM_RESTART': '1', 02:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:45 INFO - 'PWD': '/builds/slave/test', 02:59:45 INFO - 'SHELL': '/bin/bash', 02:59:45 INFO - 'SHLVL': '1', 02:59:45 INFO - 'TERM': 'linux', 02:59:45 INFO - 'TMOUT': '86400', 02:59:45 INFO - 'USER': 'cltbld', 02:59:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:45 INFO - '_': '/tools/buildbot/bin/python'} 02:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:45 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 02:59:45 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 02:59:45 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 02:59:45 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 02:59:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:46 INFO - Installing collected packages: mozsystemmonitor 02:59:46 INFO - Running setup.py install for mozsystemmonitor 02:59:46 INFO - Successfully installed mozsystemmonitor 02:59:46 INFO - Cleaning up... 02:59:46 INFO - Return code: 0 02:59:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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')]} 02:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:46 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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:46 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 02:59:46 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 02:59:46 INFO - Using env: {'DISPLAY': ':0', 02:59:46 INFO - 'HOME': '/home/cltbld', 02:59:46 INFO - 'LANG': 'en_US.UTF-8', 02:59:46 INFO - 'LANGUAGE': 'en_US:en', 02:59:46 INFO - 'LOGNAME': 'cltbld', 02:59:46 INFO - 'MAIL': '/var/mail/cltbld', 02:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:46 INFO - 'MOZ_NO_REMOTE': '1', 02:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:46 INFO - 'NO_EM_RESTART': '1', 02:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:46 INFO - 'PWD': '/builds/slave/test', 02:59:46 INFO - 'SHELL': '/bin/bash', 02:59:46 INFO - 'SHLVL': '1', 02:59:46 INFO - 'TERM': 'linux', 02:59:46 INFO - 'TMOUT': '86400', 02:59:46 INFO - 'USER': 'cltbld', 02:59:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:46 INFO - '_': '/tools/buildbot/bin/python'} 02:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:48 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 02:59:48 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 02:59:48 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 02:59:48 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 02:59:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:48 INFO - warning: no files found matching '*.txt' 02:59:48 INFO - no previously-included directories found matching 'build' 02:59:48 INFO - no previously-included directories found matching 'dist' 02:59:48 INFO - no previously-included directories found matching '.git*' 02:59:48 INFO - Installing collected packages: jsonschema, functools32 02:59:48 INFO - Running setup.py install for functools32 02:59:48 INFO - warning: no files found matching '*.txt' 02:59:48 INFO - no previously-included directories found matching 'build' 02:59:48 INFO - no previously-included directories found matching 'dist' 02:59:48 INFO - no previously-included directories found matching '.git*' 02:59:48 INFO - Successfully installed jsonschema functools32 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:59:48 INFO - Using env: {'DISPLAY': ':0', 02:59:48 INFO - 'HOME': '/home/cltbld', 02:59:48 INFO - 'LANG': 'en_US.UTF-8', 02:59:48 INFO - 'LANGUAGE': 'en_US:en', 02:59:48 INFO - 'LOGNAME': 'cltbld', 02:59:48 INFO - 'MAIL': '/var/mail/cltbld', 02:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:48 INFO - 'MOZ_NO_REMOTE': '1', 02:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:48 INFO - 'NO_EM_RESTART': '1', 02:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:48 INFO - 'PWD': '/builds/slave/test', 02:59:48 INFO - 'SHELL': '/bin/bash', 02:59:48 INFO - 'SHLVL': '1', 02:59:48 INFO - 'TERM': 'linux', 02:59:48 INFO - 'TMOUT': '86400', 02:59:48 INFO - 'USER': 'cltbld', 02:59:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:48 INFO - '_': '/tools/buildbot/bin/python'} 02:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:59:48 INFO - Using env: {'DISPLAY': ':0', 02:59:48 INFO - 'HOME': '/home/cltbld', 02:59:48 INFO - 'LANG': 'en_US.UTF-8', 02:59:48 INFO - 'LANGUAGE': 'en_US:en', 02:59:48 INFO - 'LOGNAME': 'cltbld', 02:59:48 INFO - 'MAIL': '/var/mail/cltbld', 02:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:48 INFO - 'MOZ_NO_REMOTE': '1', 02:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:48 INFO - 'NO_EM_RESTART': '1', 02:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:48 INFO - 'PWD': '/builds/slave/test', 02:59:48 INFO - 'SHELL': '/bin/bash', 02:59:48 INFO - 'SHLVL': '1', 02:59:48 INFO - 'TERM': 'linux', 02:59:48 INFO - 'TMOUT': '86400', 02:59:48 INFO - 'USER': 'cltbld', 02:59:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:48 INFO - '_': '/tools/buildbot/bin/python'} 02:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:48 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 02:59:48 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 02:59:48 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 02:59:48 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 02:59:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:50 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 02:59:50 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 02:59:50 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 02:59:50 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 02:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:50 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 02:59:50 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 02:59:50 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 02:59:50 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 02:59:50 INFO - Downloading docopt-0.6.1.tar.gz 02:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:50 INFO - Running setup.py install for blobuploader 02:59:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:50 INFO - Running setup.py install for requests 02:59:51 INFO - Running setup.py install for docopt 02:59:51 INFO - Successfully installed blobuploader requests docopt 02:59:51 INFO - Cleaning up... 02:59:51 INFO - Return code: 0 02:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:51 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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:51 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 02:59:51 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 02:59:51 INFO - Using env: {'DISPLAY': ':0', 02:59:51 INFO - 'HOME': '/home/cltbld', 02:59:51 INFO - 'LANG': 'en_US.UTF-8', 02:59:51 INFO - 'LANGUAGE': 'en_US:en', 02:59:51 INFO - 'LOGNAME': 'cltbld', 02:59:51 INFO - 'MAIL': '/var/mail/cltbld', 02:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:51 INFO - 'MOZ_NO_REMOTE': '1', 02:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:51 INFO - 'NO_EM_RESTART': '1', 02:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:51 INFO - 'PWD': '/builds/slave/test', 02:59:51 INFO - 'SHELL': '/bin/bash', 02:59:51 INFO - 'SHLVL': '1', 02:59:51 INFO - 'TERM': 'linux', 02:59:51 INFO - 'TMOUT': '86400', 02:59:51 INFO - 'USER': 'cltbld', 02:59:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:51 INFO - '_': '/tools/buildbot/bin/python'} 02:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:51 INFO - Running setup.py (path:/tmp/pip-DGXlGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:51 INFO - Running setup.py (path:/tmp/pip-SVizNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:51 INFO - Running setup.py (path:/tmp/pip-fWlvNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:51 INFO - Running setup.py (path:/tmp/pip-13LBbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:51 INFO - Running setup.py (path:/tmp/pip-yejIdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:51 INFO - Running setup.py (path:/tmp/pip-sti7Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:51 INFO - Running setup.py (path:/tmp/pip-Z2HFuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:51 INFO - Running setup.py (path:/tmp/pip-OXjbA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:51 INFO - Running setup.py (path:/tmp/pip-D8BE3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:52 INFO - Running setup.py (path:/tmp/pip-py3sv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:52 INFO - Running setup.py (path:/tmp/pip-UDyvNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:52 INFO - Running setup.py (path:/tmp/pip-pBn8uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:52 INFO - Running setup.py (path:/tmp/pip-Kg0sQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:52 INFO - Running setup.py (path:/tmp/pip-WXRtQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:52 INFO - Running setup.py (path:/tmp/pip-Sz3EP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:52 INFO - Running setup.py (path:/tmp/pip-tzSN5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:52 INFO - Running setup.py (path:/tmp/pip-LePAOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:52 INFO - Running setup.py install for manifestparser 02:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:52 INFO - Running setup.py install for mozcrash 02:59:52 INFO - Running setup.py install for mozdebug 02:59:52 INFO - Running setup.py install for mozdevice 02:59:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozfile 02:59:53 INFO - Running setup.py install for mozhttpd 02:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozinfo 02:59:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozInstall 02:59:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozleak 02:59:53 INFO - Running setup.py install for mozlog 02:59:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for moznetwork 02:59:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozprocess 02:59:53 INFO - Running setup.py install for mozprofile 02:59:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:53 INFO - Running setup.py install for mozrunner 02:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Running setup.py install for mozscreenshot 02:59:54 INFO - Running setup.py install for moztest 02:59:54 INFO - Running setup.py install for mozversion 02:59:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:54 INFO - Cleaning up... 02:59:54 INFO - Return code: 0 02:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:54 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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:54 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 02:59:54 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 02:59:54 INFO - Using env: {'DISPLAY': ':0', 02:59:54 INFO - 'HOME': '/home/cltbld', 02:59:54 INFO - 'LANG': 'en_US.UTF-8', 02:59:54 INFO - 'LANGUAGE': 'en_US:en', 02:59:54 INFO - 'LOGNAME': 'cltbld', 02:59:54 INFO - 'MAIL': '/var/mail/cltbld', 02:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:54 INFO - 'MOZ_NO_REMOTE': '1', 02:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:54 INFO - 'NO_EM_RESTART': '1', 02:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:54 INFO - 'PWD': '/builds/slave/test', 02:59:54 INFO - 'SHELL': '/bin/bash', 02:59:54 INFO - 'SHLVL': '1', 02:59:54 INFO - 'TERM': 'linux', 02:59:54 INFO - 'TMOUT': '86400', 02:59:54 INFO - 'USER': 'cltbld', 02:59:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:54 INFO - '_': '/tools/buildbot/bin/python'} 02:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:54 INFO - Running setup.py (path:/tmp/pip-6XQ01X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:54 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)) 02:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:54 INFO - Running setup.py (path:/tmp/pip-NH0kS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:54 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)) 02:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:54 INFO - Running setup.py (path:/tmp/pip-nF1ngh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:54 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)) 02:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:54 INFO - Running setup.py (path:/tmp/pip-9IubaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:54 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)) 02:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:54 INFO - Running setup.py (path:/tmp/pip-fHIs5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:54 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)) 02:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:54 INFO - Running setup.py (path:/tmp/pip-dKuqde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:55 INFO - Running setup.py (path:/tmp/pip-FHgEiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:55 INFO - Running setup.py (path:/tmp/pip-leF6ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:55 INFO - Running setup.py (path:/tmp/pip-7KSYOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:55 INFO - Running setup.py (path:/tmp/pip-jDZJyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:55 INFO - Running setup.py (path:/tmp/pip-ADjFzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:55 INFO - Running setup.py (path:/tmp/pip-HmaWYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:55 INFO - Running setup.py (path:/tmp/pip-sLZ__b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:55 INFO - Running setup.py (path:/tmp/pip-uNQCiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:55 INFO - Running setup.py (path:/tmp/pip-Ez0EI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:55 INFO - Running setup.py (path:/tmp/pip-v_XUXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:55 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)) 02:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:55 INFO - Running setup.py (path:/tmp/pip-LXhkGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:55 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)) 02:59:55 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)) 02:59:55 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)) 02:59:55 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)) 02:59:55 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)) 02:59:55 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)) 02:59:55 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)) 02:59:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:56 INFO - Downloading blessings-1.6.tar.gz 02:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:57 INFO - Installing collected packages: blessings 02:59:57 INFO - Running setup.py install for blessings 02:59:57 INFO - Successfully installed blessings 02:59:57 INFO - Cleaning up... 02:59:57 INFO - Return code: 0 02:59:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:57 INFO - Reading from file tmpfile_stdout 02:59:57 INFO - Current package versions: 02:59:57 INFO - argparse == 1.2.1 02:59:57 INFO - blessings == 1.6 02:59:57 INFO - blobuploader == 1.2.4 02:59:57 INFO - docopt == 0.6.1 02:59:57 INFO - functools32 == 3.2.3-2 02:59:57 INFO - jsonschema == 2.5.1 02:59:57 INFO - manifestparser == 1.1 02:59:57 INFO - mozInstall == 1.13 02:59:57 INFO - mozcrash == 1.0 02:59:57 INFO - mozdebug == 0.1 02:59:57 INFO - mozdevice == 0.51 02:59:57 INFO - mozfile == 1.2 02:59:57 INFO - mozhttpd == 0.7 02:59:57 INFO - mozinfo == 0.10 02:59:57 INFO - mozleak == 0.1 02:59:57 INFO - mozlog == 3.5 02:59:57 INFO - moznetwork == 0.27 02:59:57 INFO - mozprocess == 0.25 02:59:57 INFO - mozprofile == 0.28 02:59:57 INFO - mozrunner == 6.13 02:59:57 INFO - mozscreenshot == 0.1 02:59:57 INFO - mozsystemmonitor == 0.3 02:59:57 INFO - moztest == 0.8 02:59:57 INFO - mozversion == 1.4 02:59:57 INFO - psutil == 3.1.1 02:59:57 INFO - requests == 1.2.3 02:59:57 INFO - wsgiref == 0.1.2 02:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:57 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 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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 02:59:57 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 02:59:57 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 02:59:57 INFO - Using env: {'DISPLAY': ':0', 02:59:57 INFO - 'HOME': '/home/cltbld', 02:59:57 INFO - 'LANG': 'en_US.UTF-8', 02:59:57 INFO - 'LANGUAGE': 'en_US:en', 02:59:57 INFO - 'LOGNAME': 'cltbld', 02:59:57 INFO - 'MAIL': '/var/mail/cltbld', 02:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:57 INFO - 'MOZ_NO_REMOTE': '1', 02:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:57 INFO - 'NO_EM_RESTART': '1', 02:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:57 INFO - 'PWD': '/builds/slave/test', 02:59:57 INFO - 'SHELL': '/bin/bash', 02:59:57 INFO - 'SHLVL': '1', 02:59:57 INFO - 'TERM': 'linux', 02:59:57 INFO - 'TMOUT': '86400', 02:59:57 INFO - 'USER': 'cltbld', 02:59:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 02:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:57 INFO - '_': '/tools/buildbot/bin/python'} 02:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 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)) 02:59:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:58 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:59:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:59:58 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 02:59:58 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 02:59:58 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 02:59:58 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 02:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:59:59 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)) 02:59:59 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)) 02:59:59 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)) 02:59:59 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)) 02:59:59 INFO - Installing collected packages: marionette-driver, simplejson 02:59:59 INFO - Running setup.py install for marionette-driver 02:59:59 INFO - Running setup.py install for simplejson 02:59:59 INFO - building 'simplejson._speedups' extension 02:59:59 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:00 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:00 INFO - Successfully installed marionette-driver simplejson 03:00:00 INFO - Cleaning up... 03:00:00 INFO - Return code: 0 03:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:00:00 INFO - Using env: {'DISPLAY': ':0', 03:00:00 INFO - 'HOME': '/home/cltbld', 03:00:00 INFO - 'LANG': 'en_US.UTF-8', 03:00:00 INFO - 'LANGUAGE': 'en_US:en', 03:00:00 INFO - 'LOGNAME': 'cltbld', 03:00:00 INFO - 'MAIL': '/var/mail/cltbld', 03:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:00 INFO - 'MOZ_NO_REMOTE': '1', 03:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:00 INFO - 'NO_EM_RESTART': '1', 03:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:00 INFO - 'PWD': '/builds/slave/test', 03:00:00 INFO - 'SHELL': '/bin/bash', 03:00:00 INFO - 'SHLVL': '1', 03:00:00 INFO - 'TERM': 'linux', 03:00:00 INFO - 'TMOUT': '86400', 03:00:00 INFO - 'USER': 'cltbld', 03:00:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 03:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:00 INFO - '_': '/tools/buildbot/bin/python'} 03:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:00 INFO - Cleaning up... 03:00:00 INFO - Return code: 0 03:00:00 INFO - Running post-action listener: _resource_record_post_action 03:00:00 INFO - Running post-action listener: _start_resource_monitoring 03:00:00 INFO - Starting resource monitoring. 03:00:00 INFO - [mozharness: 2017-07-31 10:00:00.430580Z] Finished create-virtualenv step (success) 03:00:00 INFO - [mozharness: 2017-07-31 10:00:00.431087Z] Running install step. 03:00:00 INFO - Running pre-action listener: _resource_record_pre_action 03:00:00 INFO - Running main action method: install 03:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:00 INFO - Reading from file tmpfile_stdout 03:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:00 INFO - Reading from file tmpfile_stdout 03:00:00 INFO - Output received: 03:00:00 INFO - Usage: mozinstall [options] installer 03:00:00 INFO - Options: 03:00:00 INFO - -h, --help show this help message and exit 03:00:00 INFO - -d DEST, --destination=DEST 03:00:00 INFO - Directory to install application into. [default: 03:00:00 INFO - "/builds/slave/test"] 03:00:00 INFO - --app=APP Application being installed. [default: firefox] 03:00:00 INFO - mkdir: /builds/slave/test/build/application 03:00:00 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:00 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:18 INFO - Reading from file tmpfile_stdout 03:00:18 INFO - Output received: 03:00:18 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:18 INFO - Running post-action listener: _resource_record_post_action 03:00:18 INFO - [mozharness: 2017-07-31 10:00:18.806673Z] Finished install step (success) 03:00:18 INFO - [mozharness: 2017-07-31 10:00:18.807011Z] Running setup-mitmproxy step. 03:00:18 INFO - Running pre-action listener: _resource_record_pre_action 03:00:18 INFO - Running main action method: setup_mitmproxy 03:00:18 INFO - Skipping: mitmproxy is not required 03:00:18 INFO - Running post-action listener: _resource_record_post_action 03:00:18 INFO - [mozharness: 2017-07-31 10:00:18.808610Z] Finished setup-mitmproxy step (success) 03:00:18 INFO - [mozharness: 2017-07-31 10:00:18.809019Z] Running run-tests step. 03:00:18 INFO - Running pre-action listener: _resource_record_pre_action 03:00:18 INFO - Running pre-action listener: _set_gcov_prefix 03:00:18 INFO - Running main action method: run_tests 03:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:18 INFO - Python 2.7.3 03:00:18 INFO - Return code: 0 03:00:18 INFO - grabbing minidump binary from tooltool 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 - 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 0x13a8eb0>, '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 0x13a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:18 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:18 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:18 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:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:18 INFO - Return code: 0 03:00:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:18 INFO - ENV: RUST_BACKTRACE is now 1 03:00:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:18 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-008', '--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:18 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-008 --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: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 - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:18 INFO - 'MOZ_NO_REMOTE': '1', 03:00:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 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': '/builds/slave/test/build/venv/bin:/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 - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:18 INFO - 'RUST_BACKTRACE': '1', 03:00:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:18 INFO - 'SHELL': '/bin/bash', 03:00:18 INFO - 'SHLVL': '1', 03:00:18 INFO - 'STYLO_FORCE_ENABLED': '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': '32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237', 03:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:18 INFO - '_': '/tools/buildbot/bin/python'} 03:00:18 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-008', '--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:19 INFO - mozversion application_buildid: 20170731091117 03:00:19 INFO - mozversion application_changeset: 26516ba270816a6cc90f5c42a9b66701369a551f 03:00:19 INFO - mozversion application_display_name: Nightly 03:00:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:19 INFO - mozversion application_name: Firefox 03:00:19 INFO - mozversion application_remotingname: firefox 03:00:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:19 INFO - mozversion application_vendor: Mozilla 03:00:19 INFO - mozversion application_version: 56.0a1 03:00:19 INFO - mozversion platform_buildid: 20170731091117 03:00:19 INFO - mozversion platform_changeset: 26516ba270816a6cc90f5c42a9b66701369a551f 03:00:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:19 INFO - mozversion platform_version: 56.0a1 03:00:19 INFO - using testdate: 1501495219 03:00:19 INFO - actual date: 1501495219 03:00:19 INFO - starting webserver on 'localhost:42270' 03:00:19 INFO - SUITE-START | Running 2 tests 03:00:19 INFO - TEST-START | dromaeo_css 03:00:19 INFO - Initialising browser for dromaeo_css test... 03:00:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42270/getInfo.html -profile /tmp/tmpJFg_26/profile 03:00:19 INFO - TEST-INFO | started process 14183 (/builds/slave/test/build/application/firefox/firefox http://localhost:42270/getInfo.html) 03:00:25 INFO - TEST-INFO | 14183: exit 0 03:00:25 INFO - Browser initialized. 03:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:25 INFO - TEST-INFO | started process 14409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJFg_26/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:26 INFO - PID 14409 | 03:00:26 INFO - PID 14409 | (/builds/slave/test/build/application/firefox/firefox:14463): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:00:26 INFO - PID 14409 | 03:00:36 INFO - PID 14409 | RSS: Main: 174501888 03:00:36 INFO - PID 14409 | 03:03:36 INFO - PID 14409 | Cycle 1(1): loaded http://localhost:42270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42270/tests/dromaeo/cssquery-ext.html) 03:03:37 INFO - PID 14409 | RSS: Main: 175484928 03:03:37 INFO - PID 14409 | 03:06:39 INFO - PID 14409 | Cycle 1(1): loaded http://localhost:42270/tests/dromaeo/cssquery-ext.html (next: http://localhost:42270/tests/dromaeo/cssquery-jquery.html) 03:06:40 INFO - PID 14409 | RSS: Main: 173215744 03:06:40 INFO - PID 14409 | 03:09:42 INFO - PID 14409 | Cycle 1(1): loaded http://localhost:42270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42270/tests/dromaeo/cssquery-mootools.html) 03:09:43 INFO - PID 14409 | RSS: Main: 175788032 03:09:43 INFO - PID 14409 | 03:12:44 INFO - PID 14409 | Cycle 1(1): loaded http://localhost:42270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42270/tests/dromaeo/cssquery-prototype.html) 03:12:45 INFO - PID 14409 | RSS: Main: 172392448 03:12:45 INFO - PID 14409 | 03:15:49 INFO - PID 14409 | Cycle 1(1): loaded http://localhost:42270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42270/tests/dromaeo/cssquery-yui.html) 03:15:50 INFO - PID 14409 | RSS: Main: 177168384 03:15:50 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | Cycle 1(1): loaded http://localhost:42270/tests/dromaeo/cssquery-yui.html (next: http://localhost:42270/tests/dromaeo/cssquery-dojo.html) 03:18:52 INFO - PID 14409 | RSS: Main: 178081792 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | __start_tp_report 03:18:52 INFO - PID 14409 | _x_x_mozilla_page_load 03:18:52 INFO - PID 14409 | _x_x_mozilla_page_load_details 03:18:52 INFO - PID 14409 | |i|pagename|runs| 03:18:52 INFO - PID 14409 | |0;dojo.html;3138.6704396038417;3157.6368717597475;3166.968330316699;3171.2547551325433;3225.9032229033137;6151.292601350846;6198.783042593504;6214.161088253085;6229.1902052733085;6270.028145637428;6046.213992181021;6186.505079593633;6198.132261483396;6203.937960620392;6230.127782110497;5628.127640215773;5662.320521537421;5673.99999999999;5683.147527870811;5683.658980461165;5729.799457019005;5738.42615738427;5764.423557644244;5776.59563830532;5836.474717275444;5622.718864056781;5704.11586204139;5751.7699292028265;5791.971040144815;5794.159846822208;5491.615586908918;5625.578081643893;5632.267805185341;5697.572682048822;5708.20085188074;5614.747336369833;5645.802396916089;5683.516901063374;5712.057510510761;5740.339860916007;6079.148919151322;6080.939190608082;6162.691865406757;6200.255969283669;6226.657533835637;6599.5380323377385;6637.269900310962;6644.60132392058;6645.80062598118;6667.433268172211;6713.664316784141;6718.361755633207;6742.764003259862;6757.831054223684;6817.5227734058635;6252.499800016033;6264.310925798159;6275.560710750204;6318.273398559132;6322.209723784527;6880.174379074443;6886.2769409212315;6891.655417229119;6971.058907047585;7001.0198572198915;6472.158619379545;6549.345065493508;6568.474522038226;6600.207975042929;6676.098726671934;6610.30591787865;6625.436837868739;6633.336666333328;6635.734570617121;6641.833954151185;6509.609423434609;6537.1501704778075;6548.639824809681;6561.573497722633;6636.734530618818;6653.767118150841;6654.23476300222;6655.46756259498;6707.731690732316;6734.3602357775935;5347.625666203407;5411.56707463402;5416.0792665247;5418.295621569249;5424.918626220609;4579.7252164870215;4639.559241872017;4683.039976804746;4686.625069994392;4708.223143181405;5755.827325180251;5771.884562308815;5772.076467765138;5774.0761478163295;5780.653160810365;6507.121538592324;6685.598864068074;6700.363465470772;6703.497237707192;6712.463002959751;5447.4824891635235;5745.166950792195;5752.9424705753245;5757.827265182052;5832.358440571534;5863.149843272701;5877.823665290048;5940.227770389908;5945.078512830518;5949.8215053548465;6364.204474440695;6466.773662921869;6523.151990241238;6548.246951600531;6558.80323590293;6662.133922590032;6668.599884006975;6671.39957403836;6674.199096108498;6679.265280819009;6400.615963042046;6419.775307864203;6544.280129185881;6547.639879806466;6552.967235163794;6486.05952136947;6537.248216455168;6572.112764776694;6624.171978502687;6652.268250492539;6658.300878407697;6662.966685166737;6736.898946515904;6750.35871592198;6763.864722705617;6406.13517175194;6488.124103246001;6493.805185844432;6585.3085426029575;6593.703283352356;6471.158749362553;6481.935180648322;6486.383793539606;6487.481001519773;6493;6385.361463853763;6391.041343798467;6395.072714456471;6395.1046853441485;6494.318096599978;6420.1974753155855;6467.353264673495;6569.24453687832;6592.044153597605;6627.50293727982;6304.5271604628915;6305.40098690642;6341.587796793194;6402.647854368054;6410.1025856381075 03:18:52 INFO - PID 14409 | |1;ext.html;807.8949736534249;858.8668756342768;883.0815951410532;899.2446345070144;1155.1913660437697;30773.692263077362;31166.22084447887;37791.81104094479;38454.61545384545;42006.57993420065;42389.36415953755;42538;42585.57414425855;42711.57288427115;42770.572294277044;7075.257098004713;7468.215837337069;7595.392368610525;7631.542107473541;7727.536347819148;7581.393488520933;7675.961620191919;7691.077070751489;7698.230176982313;7703.922960770376;7656.578888161149;7676.769696909102;7725.227477252286;7726.420518461138;7731.690732370726;7608.847823043536;7672.3478504327195;7679.1936846631415;7681.961590192013;7705.537667739954;7520.435967302475;7558.47090703651;7590.316871481538;7595.202503737083;7599.240075992412;38732.031699207466;38809.22381552353;39018.21963560713;39022.60977390218;39054.60945390538;3464.359093567673;3468.7745296555895;3476.548048753671;3492.231709024011;3496.877609283663;30439;30588.8470557648;30761.846190769127;30781.076567703003;30808.229794255098;4642.048380082075;4682.859514214579;4691.437027556715;4691.460482044575;4790.305405716186;187538.06230968758;188571;189833;190134;190373;48690.513094869304;48775.756121219165;49202.753986229836;49264.75367623139;49404;50109.49890501121;50370.74814625904;50427.74786126046;50494.74752626213;50644.74677626662;13645.249511276777;13879.51421700256;13931.930340348234;13940.442382304796;13961.581152565439;9554.713358599114;9700.175485083846;10996.560137594566;11111.444427778579;11120.110391168688;14295.07082039664;14510.637234069021;14519.92740036293;14580.85419145795;14638;5721.170430287668;5820.738066787005;5829.446202610745;5894.322152952465;5909.881802363929;976.3995142987154;981.5092453773113;1005.492226425665;1008.2841182760176;1019.3221507697447;22122.889385552968;22175.334739957827;22538.774612253994;22982.816632419894;23319.88340058323;1034.7620047389144;1063.9946800266105;1099.263493459384;1106.280917403694;1119.3787447966295;11747.765044699057;11879.76240475203;12072.818907716392;12114.697132571757;12186;219414;219858;219978;220395;221274;52216;52571.21143182855;52888.73555632274;52916;52925.735371322895;1417.8723914847712;1445.4724025730532;1466.5527014260754;1471.529110684592;1472.521430535059;22263.332100037023;22523.43691407728;22644.207452739076;22867.885660571592;23197;50723.492765071875;51588.74205629098;51996.74001629968;52004.47995519996;52019.73990130025;199774;201875;202644;202799;203334;29913.551296730133;32181.678183218806;33579.66420335766;33839;33864;43383.13233735244;43566.56433435625;44342.33486497641;44482;45027;28011.859940700982;28050.2987425316;28101.156965291073;28511.572326415535;28817.7118228815;26570.734292656827;27330;28505.28736781514;29267.853660731562;29802.70197298086;37381.62618373781;37412.25175496529;37952;38096.23807523889;38349;32289.51565726563;32663;32673.836630817645;33068.66931330656;33111.50332744962;23661.763382365956;24536.631950521114;24951.126710565044;25256.873715631304;25327.860246288594 03:18:52 INFO - PID 14409 | |2;jquery.html;560.1345920552745;567.6707509644407;568.5423234296389;581.9679917604532;583.64106074764;22279.331620051405;22778.31665050051;23020.539589208205;23162.42093947648;23198.072077116914;25353;25882.870585647044;25916.96332146712;25937.351566210808;26074.348141296476;6245.875082498347;6416.262129855079;6438.710258038376;6441.967790161066;6443.194600674916;5830.5044071254;6319.842003949915;6328.778492752755;6345.111684364193;6377.808665740035;6305.684715764216;6313.084602732601;6320.273168585625;6333.904991425133;6344.080108384282;6287.276963149251;6317.399847014526;6320.905186422207;6349.1428657131155;6358.87282254357;5858.297004359461;5912.054071348563;5916.349201587822;5921.348651648315;5923.526117910556;29343;29920.40159196804;30210;30536.083917482512;30632.54051189234;1888.376835644234;1934.6711059119984;1943.523836660013;1945.8443324534144;1946.562023544691;18953.715694264596;19591.706124408145;19616.509587260432;19637.705434418494;19639.901800490905;2279.908803647852;2288.588054150269;2335.135999680112;2335.311083230451;2388.4625959159052;133785.33107334498;136354;136492;136899.31550342284;137932;14142.787858182135;14744;15117.319720612599;15233.095863017123;15541;24153.879230603736;24200.51598968046;24201.63697544538;24262.393440164138;24275.39311517226;9750.414975101517;9874.802503950024;10116.949415253024;10131.189504839595;10142.29003969715;9045.638174472948;9123.680671176477;9138.314626403046;9147.313951453667;9230.953845230864;7561.395088392916;8939.329550283755;9118.680846170351;9240.722778316662;9333;2670.5193065248054;2686.6641669791275;2695.5417579011614;2708.6614173228345;2748.993449313217;825.9050209226016;856.3277826905849;863.404251066762;865.2904618213005;869.0527325215419;18347.63304733898;18541.721874171897;18548.536286592942;18603.44189674312;20336.898315508624;900.6847603338779;914.7347269291964;950.2825366848124;957.4686049242737;964.6623681711485;9740.928497865229;9825.4104753715;10020;10370.259331434478;10846.45767711627;463898;480631;492485;518505;573874;122007.38996304962;124163;128912;129467.35266323609;129861.35069324593;1181.9763604727857;1209.3711270139654;1251.8059700746398;1252.6743046807712;1254.5107408110844;20058.699119512927;20612.381628551168;21151.153953841673;21584.02871870738;22656.320310390714;59991;61905.07142392958;62442;62447;64226.03660944996;73977.6301118491;74461.6276918612;74742;74896.25103748892;75552;14493.420263189777;15367.077975321516;15461.613459663598;15467.071975681494;15484.380624774883;21301.46746331292;21384.358469245948;21391.25130620421;23893.40266493282;24161.63757543603;19013.14440850193;19171.233150673816;19238.326658566883;19381.806181938566;19383.321583744502;14194.787078193629;14339.569812905629;14452.205128718022;15199.088054716753;15247.618809529407;18566.907165464087;19506.80493195107;19820.70268945996;19890.403287901387;20041.599168016848;15014.174220417983;15053.548393548212;15070.472533461276;15180.544583662508;15329.233538322816;18699.813001870352;18882;18918.3378581749;19018.904905475385;19228.423147305602 03:18:52 INFO - PID 14409 | |3;mootools.html;1355.5187908292555;1421.296458253165;1422.7154569086179;1435.382785402278;1435.7272118297524;13501;13698.931505342483;14127.152370857755;14167.858321416783;14170.078944868575;14208.644783880409;14503.347349369278;14506.129632222048;14518.201498917582;14542.054766440175;2653.4958357911937;2698.608701738247;2713.4980028694654;2719.0891051497774;2720.442309326593;2569.383347996477;2661.5076210900947;2700.9189724308203;2707.7292270772964;2709.796765242605;2640.0891692366104;2673.70589235184;2686.825356351831;2723.3872378714827;2734.4804487147476;2582.2769624505167;2601.2586412872333;2624.895004199839;2628.7239839816925;2632.0393056534226;2591.676040494938;2610.451805120908;2625.77680897124;2626.645402870607;2629.53983052965;13477.05660603758;13776.10455320401;13777.655558611015;13777.793333099911;13788.793168102486;7174.461915356317;7392.963035184844;7420;7422.703091876372;7431.516951398142;4895.461499235082;4977.6764510307075;5030.144875371196;5158.3552055993005;5178.97410512945;1678.6474840283556;1682.1589205397302;1722.5951901303183;1732.9480115596552;1741.8867773594802;22668.88665556678;22880.199193028166;22897.198598048988;22910.083596656114;22917.77082229173;6145.985912324506;6407.935920640827;6514;6579.47364210862;6598.637074960923;15365.769513457308;15403.691926161415;15466.767998480032;15481.922590386976;15502.224888755518;7051.647417629098;7327.5969821659255;7337.046183996046;7344.926550734531;7349.522281051714;5434.538064264581;6177.567570270128;6725.226598941184;6731.697073631698;6897.310268973163;5351.117065684196;5496.340439147328;5546.805861794898;5558.526990347561;5631.070873305859;1690.5013021158788;1735.644192940444;1744.2586900567462;1758.085795386392;1767.2665843674988;850.732019413895;859.5272600069936;869.6130222051127;898.2813749000774;914.4696076275744;6659.267480577133;6894.620795856276;6972.372486476242;7017.92982070183;7072.964635176894;719.8092505486051;725.7858931615186;729.956202627844;732.5421611492817;744.5644298085572;4319.4816622005565;4688.109259240733;4836.540528649773;4889.804407823718;5253.605979551549;19010.71483927742;19443.22227110928;19449.8055019448;19485.220591176196;19601.411957641292;17984.460466186036;18945.90527047356;18972.335968241045;19027.953462559693;19040.52398690044;10397.740056498647;10414.448460127318;10757.408342541235;10768.676939691823;10845.078168355778;7200.927990720235;7468.589227592534;7546.66040028189;7920.287174154354;8046.436749427484;15840.207989600704;16040.518784436486;16346.346146154021;16385.42651007209;16426.589335266715;13167.868321316664;15932.36270549165;16253;16317.347306107622;17238;10132.44271565071;10984.340939543654;11078.667639970814;11089.112870970464;11110.61112861046;12748.171368860994;12943.676408089874;13025.544105956626;13043.804342934674;13050.086493945333;9738.610455581698;9859.654912078044;10201.795964080527;10350;10599;9497.184511336505;9866.851997219905;9899.257555683209;10008.899911000797;10284.228682848667;8917;8947.955260223918;8977.057408971963;9063.954680226556;9087.409318394548;6448.419642232222;6833.2483426824;6847.315268473113;6933.687984040629;6949.513534052568;6253.624782513064;6425.5502114851515;6784.559003664746;6848.623325717133;6889.379955804002 03:18:52 INFO - PID 14409 | |4;prototype.html;489.1342324086367;496.17387050560797;521.7938914128918;524.6982984783746;534.0200731657409;6203.255609326881;6237.750489980407;6278.717457714408;6329.303776584572;6340.270868850083;5997.3416216108135;6052.939470605293;6113.663748493831;6124.173236613055;6194.3805619438035;4995.475475075119;4998.750062496879;5005.874853128665;5020.824271150511;5055.772490237939;4969.527894850002;4989.700617962916;4996.1756310208775;5021.472745361721;5031.84904452867;4672.929906051412;4872.6345524085655;4889.926651100236;4899.436564795059;4940.530649588283;4890.95109048912;4897.951020489803;4903.485134060944;4910.410750709902;4980.327655766461;4380.759058251795;4412.845550405753;4470.463544374663;4486.820527178941;4490.663200259994;6057.3639767824625;6065.727042283063;6103.542234332398;6154.692265386713;6189.350118237565;5764.106563482667;5768.673205162836;5768.990426675357;5769.798057067983;5776.97111514444;6518.217813862319;6541.640209788459;6542.509311801634;6552.836179095513;6583.242927063401;4846.418429788413;4872.244802055687;4879.097366987119;4881.780319885614;4896.36347274852;6814.557053791537;6922.757703480354;6968.094147760809;6974.302569743036;7012.614306213156;4893.7063776173545;4947.604191664658;4952.8761780955765;4953.801847926043;4989.501049894981;4961.2558116282125;4995.650304478651;5000.224965130411;5017.37282839645;5044.486654003857;5562.554995600342;5612.663240205601;5680.630759000652;5698.202251684767;5741.7990370337675;6531.477481801445;6560.573562718408;6579.407853293226;6594.9670251649395;6597.439217666552;1662.2602941690832;1698.244281294812;1738.330742664058;1752.649470105984;1764.8941063535972;1203.1096988228649;1210.328267811373;1224.3878060969516;1235.6169587427926;1253.0852477691337;5705.572082093777;5742.253507044057;5813.244278243886;5845.9707701462075;5850.3564607893095;6523.7716679915975;6591.703373348115;6666.333416645839;6669;6711.865762684719;5681.687507187145;5693.658380497183;5705.343885453226;5776.42235776419;5819.592628515963;3561.679448849616;3582.390993531106;3615.1865830188;3627.4014787560286;3656.2870240302886;6525.249596296392;6538.640374779433;6541.607503549707;6563.50773691975;6613.735450582019;6835.453163746988;6860.451163906875;6870.931290687129;6891.552049116792;6929.792106236821;6390.329015453496;6466.385693359123;6475.255345635218;6552.246491653425;6559.573627714183;6634.436072933855;6684.6991885364305;6706.497012724163;6710.932890671031;6762.715084133999;6602.3397660233595;6608.240052394036;6635.6350400728425;6695.263521012587;6778.779819632514;6488.318726533646;6564.4420224281475;6583.539152259296;6647.135872336566;6653.767118151035;4942.135126352946;4959.504049595012;4994.775235114501;5021.096202683552;5050.949490505048;6739.865202695821;6780.220274668476;6802.217744959393;6808.148981377328;6837.726490940307;6382.20222472191;6470.094186813756;6498.545101842826;6509.316521765147;6610.702518386588;6427.839304017437;6473.579217350857;6498.252700939453;6513.576617519846;6564.376384243489;6131.877362452637;6230.906536401867;6366.376573973792;6399.55203135776;6482.319356467503;6277.30949595535;6481.5786973848435;6541.803745887631;6555.836104097245;6568.638724870178;6286.968565157145;6344.30212676596;6347.809565713036;6416.230052393743;6416.363827224028 03:18:52 INFO - PID 14409 | |5;yui.html;898.2364989758704;903.494043335732;910.804177101923;911.3529394130168;921.3550514639754;16618.08600526972;17351.305947762074;17352.739708904362;17368.13159342031;20268.087936042877;19620.275282946313;19745.901270493665;19758.209671613153;19804.207831686752;19892.9005354973;960.4141473701037;1038.8026275007762;1039.8960103989577;1043.8382050782102;1045.0751085289498;1043.9217058720587;1047.9214058945572;1049.979000419991;1053.210092430677;1053.3890343600692;777.4208214879923;790.9802254943644;1026.3277553202665;1074.693712291997;1078.1751959750798;1058.534244932231;1062.1237479079753;1063.4044934836477;1067.754416484213;1067.8291473364225;778.0624347661055;778.8909552662575;782.5148407987084;784.705735349244;785.7524879662946;19131;19690.31083912056;19870.205191792313;19971.101300441514;20113.79886201134;20207.898960505252;20484.897575512026;20855.270065547633;20885.582288354148;21233.787662123337;15313;15520.068795872285;15526.922365388215;15563.299651515708;15859.762103568455;3571.8928432146818;3612.060864175307;3614.8554057837655;3616.529851119364;3622;117325.41337293344;119599;121666;121790;125150.37424812908;16132.435364762177;16737.665246694996;16761.91619041897;16769.496915092568;16785;29905;30172;30259.848700756356;30275.243118922204;30322;8228.794280143044;8639.265662418638;8754.387192896564;8778.385513014027;8874.156955089256;4103.117829666636;4210.831566737357;4221.155768846243;4236.428082208924;4245.257080011047;5591.440855914458;5664.688442135722;5707.743151558107;5763.0202865512965;5765.250517432707;1016.5781200801584;1045.7699306152786;1049.2655141400896;1062.3678911047914;1063.2025980514613;644.2269276867777;650.5933791380387;658.5324419661998;695.422799076765;700.4851434195862;11499.540018399337;12162.756744865053;12708.364581770875;12828.35858207086;13046.347682615831;645.3030726815028;651.8142329436088;656.255150404285;664.2228592546732;664.833791552112;5362.892742145214;5383.67697938125;5466.753996070107;5491.862703432446;5669.858253543612;96925.51537242268;100714.91421029523;101528;102509.48745256376;104627;87640.5617971906;92359.53820230855;92657;93559;93890.53054734683;74830.62584687151;79109;79525.60237198777;80730;80918.22811761247;12161;12398;12445.875541244472;12831.037672174438;12929.741405172032;32575.837120814245;33235.50146747849;34149.82925085458;34903.82548087243;35411;40615;41959;43007;43699.78150109229;44519.77740111409;17873.106344682456;18203.908980455013;18368.54078647991;18564.350247741266;18595.907020464812;19943.60112797765;20141.39575812728;20682.27612033632;20803.79196208079;21113.472163196042;18169.909150454165;18771.718424223374;18787.06064696787;19094.522636934187;19155.425337239903;17536.82463175352;17709.20308586091;18066.36767713124;19682.80317196867;19702.21191152338;19174.808251917304;19244.711329330352;19770.50573735668;19987.400377988684;20013.59972800565;12096.576619818265;12274.509019639114;12418.75162496763;12764.106512544033;12865.742685146432;13012.28432436225;13716.177029378268;13917.652058698613;14732.55802325932;15099.622509437351 03:18:52 INFO - PID 14409 | __end_tp_report 03:18:52 INFO - PID 14409 | __start_cc_report 03:18:52 INFO - PID 14409 | _x_x_mozilla_cycle_collect,377 03:18:52 INFO - PID 14409 | __end_cc_report 03:18:52 INFO - PID 14409 | __startTimestamp1501496332458__endTimestamp 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | ------- Summary: start ------- 03:18:52 INFO - PID 14409 | Number of tests: 6 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | [#0] dojo.html Cycles:165 Average:6139.14 Median:6395.10 stddev:720.53 (11.3%) stddev-sans-first:683.21 03:18:52 INFO - PID 14409 | Values: 3138.7 3157.6 3167.0 3171.3 3225.9 6151.3 6198.8 6214.2 6229.2 6270.0 6046.2 6186.5 6198.1 6203.9 6230.1 5628.1 5662.3 5674.0 5683.1 5683.7 5729.8 5738.4 5764.4 5776.6 5836.5 5622.7 5704.1 5751.8 5792.0 5794.2 5491.6 5625.6 5632.3 5697.6 5708.2 5614.7 5645.8 5683.5 5712.1 5740.3 6079.1 6080.9 6162.7 6200.3 6226.7 6599.5 6637.3 6644.6 6645.8 6667.4 6713.7 6718.4 6742.8 6757.8 6817.5 6252.5 6264.3 6275.6 6318.3 6322.2 6880.2 6886.3 6891.7 6971.1 7001.0 6472.2 6549.3 6568.5 6600.2 6676.1 6610.3 6625.4 6633.3 6635.7 6641.8 6509.6 6537.2 6548.6 6561.6 6636.7 6653.8 6654.2 6655.5 6707.7 6734.4 5347.6 5411.6 5416.1 5418.3 5424.9 4579.7 4639.6 4683.0 4686.6 4708.2 5755.8 5771.9 5772.1 5774.1 5780.7 6507.1 6685.6 6700.4 6703.5 6712.5 5447.5 5745.2 5752.9 5757.8 5832.4 5863.1 5877.8 5940.2 5945.1 5949.8 6364.2 6466.8 6523.2 6548.2 6558.8 6662.1 6668.6 6671.4 6674.2 6679.3 6400.6 6419.8 6544.3 6547.6 6553.0 6486.1 6537.2 6572.1 6624.2 6652.3 6658.3 6663.0 6736.9 6750.4 6763.9 6406.1 6488.1 6493.8 6585.3 6593.7 6471.2 6481.9 6486.4 6487.5 6493.0 6385.4 6391.0 6395.1 6395.1 6494.3 6420.2 6467.4 6569.2 6592.0 6627.5 6304.5 6305.4 6341.6 6402.6 6410.1 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | [#1] ext.html Cycles:180 Average:37367.10 Median:3472.66 stddev:53026.40 (1527.0%) stddev-sans-first:53104.09 03:18:52 INFO - PID 14409 | Values: 807.9 858.9 883.1 899.2 1155.2 30773.7 31166.2 37791.8 38454.6 42006.6 42389.4 42538.0 42585.6 42711.6 42770.6 7075.3 7468.2 7595.4 7631.5 7727.5 7581.4 7676.0 7691.1 7698.2 7703.9 7656.6 7676.8 7725.2 7726.4 7731.7 7608.8 7672.3 7679.2 7682.0 7705.5 7520.4 7558.5 7590.3 7595.2 7599.2 38732.0 38809.2 39018.2 39022.6 39054.6 3464.4 3468.8 3476.5 3492.2 3496.9 30439.0 30588.8 30761.8 30781.1 30808.2 4642.0 4682.9 4691.4 4691.5 4790.3 187538.1 188571.0 189833.0 190134.0 190373.0 48690.5 48775.8 49202.8 49264.8 49404.0 50109.5 50370.7 50427.7 50494.7 50644.7 13645.2 13879.5 13931.9 13940.4 13961.6 9554.7 9700.2 10996.6 11111.4 11120.1 14295.1 14510.6 14519.9 14580.9 14638.0 5721.2 5820.7 5829.4 5894.3 5909.9 976.4 981.5 1005.5 1008.3 1019.3 22122.9 22175.3 22538.8 22982.8 23319.9 1034.8 1064.0 1099.3 1106.3 1119.4 11747.8 11879.8 12072.8 12114.7 12186.0 219414.0 219858.0 219978.0 220395.0 221274.0 52216.0 52571.2 52888.7 52916.0 52925.7 1417.9 1445.5 1466.6 1471.5 1472.5 22263.3 22523.4 22644.2 22867.9 23197.0 50723.5 51588.7 51996.7 52004.5 52019.7 199774.0 201875.0 202644.0 202799.0 203334.0 29913.6 32181.7 33579.7 33839.0 33864.0 43383.1 43566.6 44342.3 44482.0 45027.0 28011.9 28050.3 28101.2 28511.6 28817.7 26570.7 27330.0 28505.3 29267.9 29802.7 37381.6 37412.3 37952.0 38096.2 38349.0 32289.5 32663.0 32673.8 33068.7 33111.5 23661.8 24536.6 24951.1 25256.9 25327.9 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | [#2] jquery.html Cycles:180 Average:35797.77 Median:24157.76 stddev:85607.64 (354.4%) stddev-sans-first:85806.91 03:18:52 INFO - PID 14409 | Values: 560.1 567.7 568.5 582.0 583.6 22279.3 22778.3 23020.5 23162.4 23198.1 25353.0 25882.9 25917.0 25937.4 26074.3 6245.9 6416.3 6438.7 6442.0 6443.2 5830.5 6319.8 6328.8 6345.1 6377.8 6305.7 6313.1 6320.3 6333.9 6344.1 6287.3 6317.4 6320.9 6349.1 6358.9 5858.3 5912.1 5916.3 5921.3 5923.5 29343.0 29920.4 30210.0 30536.1 30632.5 1888.4 1934.7 1943.5 1945.8 1946.6 18953.7 19591.7 19616.5 19637.7 19639.9 2279.9 2288.6 2335.1 2335.3 2388.5 133785.3 136354.0 136492.0 136899.3 137932.0 14142.8 14744.0 15117.3 15233.1 15541.0 24153.9 24200.5 24201.6 24262.4 24275.4 9750.4 9874.8 10116.9 10131.2 10142.3 9045.6 9123.7 9138.3 9147.3 9231.0 7561.4 8939.3 9118.7 9240.7 9333.0 2670.5 2686.7 2695.5 2708.7 2749.0 825.9 856.3 863.4 865.3 869.1 18347.6 18541.7 18548.5 18603.4 20336.9 900.7 914.7 950.3 957.5 964.7 9740.9 9825.4 10020.0 10370.3 10846.5 463898.0 480631.0 492485.0 518505.0 573874.0 122007.4 124163.0 128912.0 129467.4 129861.4 1182.0 1209.4 1251.8 1252.7 1254.5 20058.7 20612.4 21151.2 21584.0 22656.3 59991.0 61905.1 62442.0 62447.0 64226.0 73977.6 74461.6 74742.0 74896.3 75552.0 14493.4 15367.1 15461.6 15467.1 15484.4 21301.5 21384.4 21391.3 23893.4 24161.6 19013.1 19171.2 19238.3 19381.8 19383.3 14194.8 14339.6 14452.2 15199.1 15247.6 18566.9 19506.8 19820.7 19890.4 20041.6 15014.2 15053.5 15070.5 15180.5 15329.2 18699.8 18882.0 18918.3 19018.9 19228.4 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | [#3] mootools.html Cycles:180 Average:8465.33 Median:2636.06 stddev:5810.35 (220.4%) stddev-sans-first:5802.10 03:18:52 INFO - PID 14409 | Values: 1355.5 1421.3 1422.7 1435.4 1435.7 13501.0 13698.9 14127.2 14167.9 14170.1 14208.6 14503.3 14506.1 14518.2 14542.1 2653.5 2698.6 2713.5 2719.1 2720.4 2569.4 2661.5 2700.9 2707.7 2709.8 2640.1 2673.7 2686.8 2723.4 2734.5 2582.3 2601.3 2624.9 2628.7 2632.0 2591.7 2610.5 2625.8 2626.6 2629.5 13477.1 13776.1 13777.7 13777.8 13788.8 7174.5 7393.0 7420.0 7422.7 7431.5 4895.5 4977.7 5030.1 5158.4 5179.0 1678.6 1682.2 1722.6 1732.9 1741.9 22668.9 22880.2 22897.2 22910.1 22917.8 6146.0 6407.9 6514.0 6579.5 6598.6 15365.8 15403.7 15466.8 15481.9 15502.2 7051.6 7327.6 7337.0 7344.9 7349.5 5434.5 6177.6 6725.2 6731.7 6897.3 5351.1 5496.3 5546.8 5558.5 5631.1 1690.5 1735.6 1744.3 1758.1 1767.3 850.7 859.5 869.6 898.3 914.5 6659.3 6894.6 6972.4 7017.9 7073.0 719.8 725.8 730.0 732.5 744.6 4319.5 4688.1 4836.5 4889.8 5253.6 19010.7 19443.2 19449.8 19485.2 19601.4 17984.5 18945.9 18972.3 19028.0 19040.5 10397.7 10414.4 10757.4 10768.7 10845.1 7200.9 7468.6 7546.7 7920.3 8046.4 15840.2 16040.5 16346.3 16385.4 16426.6 13167.9 15932.4 16253.0 16317.3 17238.0 10132.4 10984.3 11078.7 11089.1 11110.6 12748.2 12943.7 13025.5 13043.8 13050.1 9738.6 9859.7 10201.8 10350.0 10599.0 9497.2 9866.9 9899.3 10008.9 10284.2 8917.0 8948.0 8977.1 9064.0 9087.4 6448.4 6833.2 6847.3 6933.7 6949.5 6253.6 6425.6 6784.6 6848.6 6889.4 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | [#4] prototype.html Cycles:180 Average:5502.51 Median:6118.92 stddev:1548.28 (25.3%) stddev-sans-first:1506.20 03:18:52 INFO - PID 14409 | Values: 489.1 496.2 521.8 524.7 534.0 6203.3 6237.8 6278.7 6329.3 6340.3 5997.3 6052.9 6113.7 6124.2 6194.4 4995.5 4998.8 5005.9 5020.8 5055.8 4969.5 4989.7 4996.2 5021.5 5031.8 4672.9 4872.6 4889.9 4899.4 4940.5 4891.0 4898.0 4903.5 4910.4 4980.3 4380.8 4412.8 4470.5 4486.8 4490.7 6057.4 6065.7 6103.5 6154.7 6189.4 5764.1 5768.7 5769.0 5769.8 5777.0 6518.2 6541.6 6542.5 6552.8 6583.2 4846.4 4872.2 4879.1 4881.8 4896.4 6814.6 6922.8 6968.1 6974.3 7012.6 4893.7 4947.6 4952.9 4953.8 4989.5 4961.3 4995.7 5000.2 5017.4 5044.5 5562.6 5612.7 5680.6 5698.2 5741.8 6531.5 6560.6 6579.4 6595.0 6597.4 1662.3 1698.2 1738.3 1752.6 1764.9 1203.1 1210.3 1224.4 1235.6 1253.1 5705.6 5742.3 5813.2 5846.0 5850.4 6523.8 6591.7 6666.3 6669.0 6711.9 5681.7 5693.7 5705.3 5776.4 5819.6 3561.7 3582.4 3615.2 3627.4 3656.3 6525.2 6538.6 6541.6 6563.5 6613.7 6835.5 6860.5 6870.9 6891.6 6929.8 6390.3 6466.4 6475.3 6552.2 6559.6 6634.4 6684.7 6706.5 6710.9 6762.7 6602.3 6608.2 6635.6 6695.3 6778.8 6488.3 6564.4 6583.5 6647.1 6653.8 4942.1 4959.5 4994.8 5021.1 5050.9 6739.9 6780.2 6802.2 6808.1 6837.7 6382.2 6470.1 6498.5 6509.3 6610.7 6427.8 6473.6 6498.3 6513.6 6564.4 6131.9 6230.9 6366.4 6399.6 6482.3 6277.3 6481.6 6541.8 6555.8 6568.6 6287.0 6344.3 6347.8 6416.2 6416.4 03:18:52 INFO - PID 14409 | 03:18:52 INFO - PID 14409 | [#5] yui.html Cycles:180 Average:22051.61 Median:19918.25 stddev:29324.86 (147.2%) stddev-sans-first:29364.11 03:18:52 INFO - PID 14409 | Values: 898.2 903.5 910.8 911.4 921.4 16618.1 17351.3 17352.7 17368.1 20268.1 19620.3 19745.9 19758.2 19804.2 19892.9 960.4 1038.8 1039.9 1043.8 1045.1 1043.9 1047.9 1050.0 1053.2 1053.4 777.4 791.0 1026.3 1074.7 1078.2 1058.5 1062.1 1063.4 1067.8 1067.8 778.1 778.9 782.5 784.7 785.8 19131.0 19690.3 19870.2 19971.1 20113.8 20207.9 20484.9 20855.3 20885.6 21233.8 15313.0 15520.1 15526.9 15563.3 15859.8 3571.9 3612.1 3614.9 3616.5 3622.0 117325.4 119599.0 121666.0 121790.0 125150.4 16132.4 16737.7 16761.9 16769.5 16785.0 29905.0 30172.0 30259.8 30275.2 30322.0 8228.8 8639.3 8754.4 8778.4 8874.2 4103.1 4210.8 4221.2 4236.4 4245.3 5591.4 5664.7 5707.7 5763.0 5765.3 1016.6 1045.8 1049.3 1062.4 1063.2 644.2 650.6 658.5 695.4 700.5 11499.5 12162.8 12708.4 12828.4 13046.3 645.3 651.8 656.3 664.2 664.8 5362.9 5383.7 5466.8 5491.9 5669.9 96925.5 100714.9 101528.0 102509.5 104627.0 87640.6 92359.5 92657.0 93559.0 93890.5 74830.6 79109.0 79525.6 80730.0 80918.2 12161.0 12398.0 12445.9 12831.0 12929.7 32575.8 33235.5 34149.8 34903.8 35411.0 40615.0 41959.0 43007.0 43699.8 44519.8 17873.1 18203.9 18368.5 18564.4 18595.9 19943.6 20141.4 20682.3 20803.8 21113.5 18169.9 18771.7 18787.1 19094.5 19155.4 17536.8 17709.2 18066.4 19682.8 19702.2 19174.8 19244.7 19770.5 19987.4 20013.6 12096.6 12274.5 12418.8 12764.1 12865.7 13012.3 13716.2 13917.7 14732.6 15099.6 03:18:52 INFO - PID 14409 | -------- Summary: end -------- 03:18:52 INFO - PID 14409 | 03:18:53 INFO - TEST-INFO | 14409: exit 0 03:18:53 INFO - TEST-OK | dromaeo_css | took 1114016ms 03:18:53 INFO - TEST-START | kraken 03:18:53 INFO - Initialising browser for kraken test... 03:18:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42270/getInfo.html -profile /tmp/tmpie7UJY/profile 03:18:53 INFO - TEST-INFO | started process 14785 (/builds/slave/test/build/application/firefox/firefox http://localhost:42270/getInfo.html) 03:18:59 INFO - TEST-INFO | 14785: exit 0 03:18:59 INFO - Browser initialized. 03:18:59 INFO - Running cycle 1/1 for kraken test... 03:18:59 INFO - TEST-INFO | started process 15010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpie7UJY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:00 INFO - PID 15010 | 03:19:00 INFO - PID 15010 | (/builds/slave/test/build/application/firefox/firefox:15064): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:00 INFO - PID 15010 | 03:19:10 INFO - PID 15010 | RSS: Main: 173723648 03:19:10 INFO - PID 15010 | 03:19:13 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42270/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:14 INFO - PID 15010 | RSS: Main: 178720768 03:19:14 INFO - PID 15010 | 03:19:17 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42270/tests/kraken/driver.html?testName=audio-dft) 03:19:17 INFO - PID 15010 | RSS: Main: 178675712 03:19:17 INFO - PID 15010 | 03:19:20 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42270/tests/kraken/driver.html?testName=audio-fft) 03:19:21 INFO - PID 15010 | RSS: Main: 174014464 03:19:21 INFO - PID 15010 | 03:19:23 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42270/tests/kraken/driver.html?testName=audio-oscillator) 03:19:24 INFO - PID 15010 | RSS: Main: 174624768 03:19:24 INFO - PID 15010 | 03:19:26 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:27 INFO - PID 15010 | RSS: Main: 174710784 03:19:27 INFO - PID 15010 | 03:19:30 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42270/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:30 INFO - PID 15010 | RSS: Main: 177631232 03:19:30 INFO - PID 15010 | 03:19:34 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42270/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:35 INFO - PID 15010 | RSS: Main: 176943104 03:19:35 INFO - PID 15010 | 03:19:38 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42270/tests/kraken/driver.html?testName=json-parse-financial) 03:19:38 INFO - PID 15010 | RSS: Main: 178057216 03:19:38 INFO - PID 15010 | 03:19:40 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:41 INFO - PID 15010 | RSS: Main: 177942528 03:19:41 INFO - PID 15010 | 03:19:42 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:43 INFO - PID 15010 | RSS: Main: 175218688 03:19:43 INFO - PID 15010 | 03:19:45 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:46 INFO - PID 15010 | RSS: Main: 174944256 03:19:46 INFO - PID 15010 | 03:19:49 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:50 INFO - PID 15010 | RSS: Main: 175460352 03:19:50 INFO - PID 15010 | 03:19:53 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:53 INFO - PID 15010 | RSS: Main: 175108096 03:19:53 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | Cycle 1(1): loaded http://localhost:42270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42270/tests/kraken/driver.html?testName=ai-astar) 03:19:55 INFO - PID 15010 | RSS: Main: 177156096 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | __start_tp_report 03:19:55 INFO - PID 15010 | _x_x_mozilla_page_load 03:19:55 INFO - PID 15010 | _x_x_mozilla_page_load_details 03:19:55 INFO - PID 15010 | |i|pagename|runs| 03:19:55 INFO - PID 15010 | |0;ai-astar;100;109;104;108;108;110;108;102;108;109 03:19:55 INFO - PID 15010 | |1;audio-beat-detection;147;118;140;177;121;143;148;123;168;119 03:19:55 INFO - PID 15010 | |2;audio-dft;164;165;168;161;163;163;165;171;167;172 03:19:55 INFO - PID 15010 | |3;audio-fft;74;75;75;182;77;76;81;79;162;76 03:19:55 INFO - PID 15010 | |4;audio-oscillator;79;78;139;79;78;80;125;79;78;137 03:19:55 INFO - PID 15010 | |5;imaging-gaussian-blur;115;114;115;114;114;117;117;120;115;114 03:19:55 INFO - PID 15010 | |6;imaging-darkroom;151;152;151;153;158;151;151;153;150;150 03:19:55 INFO - PID 15010 | |7;imaging-desaturate;99;94;101;99;94;94;93;98;96;94 03:19:55 INFO - PID 15010 | |8;json-parse-financial;57;57;58;62;56;57;55;55;56;57 03:19:55 INFO - PID 15010 | |9;json-stringify-tinderbox;54;54;54;54;54;53;54;54;55;54 03:19:55 INFO - PID 15010 | |10;stanford-crypto-aes;80;81;82;87;88;81;79;89;79;84 03:19:55 INFO - PID 15010 | |11;stanford-crypto-ccm;147;134;130;130;139;128;136;137;130;168 03:19:55 INFO - PID 15010 | |12;stanford-crypto-pbkdf2;187;183;178;180;187;184;185;198;179;199 03:19:55 INFO - PID 15010 | |13;stanford-crypto-sha256-iterative;69;68;67;70;70;68;66;66;67;67 03:19:55 INFO - PID 15010 | __end_tp_report 03:19:55 INFO - PID 15010 | __start_cc_report 03:19:55 INFO - PID 15010 | _x_x_mozilla_cycle_collect,946 03:19:55 INFO - PID 15010 | __end_cc_report 03:19:55 INFO - PID 15010 | __startTimestamp1501496395905__endTimestamp 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | ------- Summary: start ------- 03:19:55 INFO - PID 15010 | Number of tests: 14 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#0] ai-astar Cycles:10 Average:106.60 Median:108.00 stddev:3.37 (3.1%) stddev-sans-first:2.60 03:19:55 INFO - PID 15010 | Values: 100.0 109.0 104.0 108.0 108.0 110.0 108.0 102.0 108.0 109.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:145.00 stddev:20.68 (14.3%) stddev-sans-first:21.79 03:19:55 INFO - PID 15010 | Values: 147.0 118.0 140.0 177.0 121.0 143.0 148.0 123.0 168.0 119.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:3.57 (2.2%) stddev-sans-first:3.72 03:19:55 INFO - PID 15010 | Values: 164.0 165.0 168.0 161.0 163.0 163.0 165.0 171.0 167.0 172.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:40.54 (53.3%) stddev-sans-first:42.23 03:19:55 INFO - PID 15010 | Values: 74.0 75.0 75.0 182.0 77.0 76.0 81.0 79.0 162.0 76.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:78.50 stddev:26.79 (34.1%) stddev-sans-first:27.77 03:19:55 INFO - PID 15010 | Values: 79.0 78.0 139.0 79.0 78.0 80.0 125.0 79.0 78.0 137.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 03:19:55 INFO - PID 15010 | Values: 115.0 114.0 115.0 114.0 114.0 117.0 117.0 120.0 115.0 114.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.50 stddev:2.36 (1.6%) stddev-sans-first:2.47 03:19:55 INFO - PID 15010 | Values: 151.0 152.0 151.0 153.0 158.0 151.0 151.0 153.0 150.0 150.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.00 stddev:2.82 (3.0%) stddev-sans-first:2.80 03:19:55 INFO - PID 15010 | Values: 99.0 94.0 101.0 99.0 94.0 94.0 93.0 98.0 96.0 94.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.00 (3.5%) stddev-sans-first:2.12 03:19:55 INFO - PID 15010 | Values: 57.0 57.0 58.0 62.0 56.0 57.0 55.0 55.0 56.0 57.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 03:19:55 INFO - PID 15010 | Values: 54.0 54.0 54.0 54.0 54.0 53.0 54.0 54.0 55.0 54.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:3.77 (4.5%) stddev-sans-first:3.84 03:19:55 INFO - PID 15010 | Values: 80.0 81.0 82.0 87.0 88.0 81.0 79.0 89.0 79.0 84.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:136.50 stddev:11.99 (8.8%) stddev-sans-first:12.26 03:19:55 INFO - PID 15010 | Values: 147.0 134.0 130.0 130.0 139.0 128.0 136.0 137.0 130.0 168.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.00 Median:186.00 stddev:7.29 (3.9%) stddev-sans-first:7.72 03:19:55 INFO - PID 15010 | Values: 187.0 183.0 178.0 180.0 187.0 184.0 185.0 198.0 179.0 199.0 03:19:55 INFO - PID 15010 | 03:19:55 INFO - PID 15010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 03:19:55 INFO - PID 15010 | Values: 69.0 68.0 67.0 70.0 70.0 68.0 66.0 66.0 67.0 67.0 03:19:55 INFO - PID 15010 | -------- Summary: end -------- 03:19:55 INFO - PID 15010 | 03:19:56 INFO - PID 15010 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:19:56 INFO - TEST-INFO | 15010: exit 0 03:19:56 INFO - TEST-OK | kraken | took 63441ms 03:19:56 INFO - SUITE-END | took 1177s 03:19:57 INFO - Completed test suite (00:19:37) 03:19:57 INFO - javascript benchmark 03:19:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8362.998906005865, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.6704396038417, 3157.6368717597475, 3166.968330316699, 3171.2547551325433, 3225.9032229033137, 6151.292601350846, 6198.783042593504, 6214.161088253085, 6229.1902052733085, 6270.028145637428, 6046.213992181021, 6186.505079593633, 6198.132261483396, 6203.937960620392, 6230.127782110497, 5628.127640215773, 5662.320521537421, 5673.99999999999, 5683.147527870811, 5683.658980461165, 5729.799457019005, 5738.42615738427, 5764.423557644244, 5776.59563830532, 5836.474717275444, 5622.718864056781, 5704.11586204139, 5751.7699292028265, 5791.971040144815, 5794.159846822208, 5491.615586908918, 5625.578081643893, 5632.267805185341, 5697.572682048822, 5708.20085188074, 5614.747336369833, 5645.802396916089, 5683.516901063374, 5712.057510510761, 5740.339860916007, 6079.148919151322, 6080.939190608082, 6162.691865406757, 6200.255969283669, 6226.657533835637, 6599.5380323377385, 6637.269900310962, 6644.60132392058, 6645.80062598118, 6667.433268172211, 6713.664316784141, 6718.361755633207, 6742.764003259862, 6757.831054223684, 6817.5227734058635, 6252.499800016033, 6264.310925798159, 6275.560710750204, 6318.273398559132, 6322.209723784527, 6880.174379074443, 6886.2769409212315, 6891.655417229119, 6971.058907047585, 7001.0198572198915, 6472.158619379545, 6549.345065493508, 6568.474522038226, 6600.207975042929, 6676.098726671934, 6610.30591787865, 6625.436837868739, 6633.336666333328, 6635.734570617121, 6641.833954151185, 6509.609423434609, 6537.1501704778075, 6548.639824809681, 6561.573497722633, 6636.734530618818, 6653.767118150841, 6654.23476300222, 6655.46756259498, 6707.731690732316, 6734.3602357775935, 5347.625666203407, 5411.56707463402, 5416.0792665247, 5418.295621569249, 5424.918626220609, 4579.7252164870215, 4639.559241872017, 4683.039976804746, 4686.625069994392, 4708.223143181405, 5755.827325180251, 5771.884562308815, 5772.076467765138, 5774.0761478163295, 5780.653160810365, 6507.121538592324, 6685.598864068074, 6700.363465470772, 6703.497237707192, 6712.463002959751, 5447.4824891635235, 5745.166950792195, 5752.9424705753245, 5757.827265182052, 5832.358440571534, 5863.149843272701, 5877.823665290048, 5940.227770389908, 5945.078512830518, 5949.8215053548465, 6364.204474440695, 6466.773662921869, 6523.151990241238, 6548.246951600531, 6558.80323590293, 6662.133922590032, 6668.599884006975, 6671.39957403836, 6674.199096108498, 6679.265280819009, 6400.615963042046, 6419.775307864203, 6544.280129185881, 6547.639879806466, 6552.967235163794, 6486.05952136947, 6537.248216455168, 6572.112764776694, 6624.171978502687, 6652.268250492539, 6658.300878407697, 6662.966685166737, 6736.898946515904, 6750.35871592198, 6763.864722705617, 6406.13517175194, 6488.124103246001, 6493.805185844432, 6585.3085426029575, 6593.703283352356, 6471.158749362553, 6481.935180648322, 6486.383793539606, 6487.481001519773, 6493.0, 6385.361463853763, 6391.041343798467, 6395.072714456471, 6395.1046853441485, 6494.318096599978, 6420.1974753155855, 6467.353264673495, 6569.24453687832, 6592.044153597605, 6627.50293727982, 6304.5271604628915, 6305.40098690642, 6341.587796793194, 6402.647854368054, 6410.1025856381075], "value": 6085.576686310683, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.8949736534249, 858.8668756342768, 883.0815951410532, 899.2446345070144, 1155.1913660437697, 30773.692263077362, 31166.22084447887, 37791.81104094479, 38454.61545384545, 42006.57993420065, 42389.36415953755, 42538.0, 42585.57414425855, 42711.57288427115, 42770.572294277044, 7075.257098004713, 7468.215837337069, 7595.392368610525, 7631.542107473541, 7727.536347819148, 7581.393488520933, 7675.961620191919, 7691.077070751489, 7698.230176982313, 7703.922960770376, 7656.578888161149, 7676.769696909102, 7725.227477252286, 7726.420518461138, 7731.690732370726, 7608.847823043536, 7672.3478504327195, 7679.1936846631415, 7681.961590192013, 7705.537667739954, 7520.435967302475, 7558.47090703651, 7590.316871481538, 7595.202503737083, 7599.240075992412, 38732.031699207466, 38809.22381552353, 39018.21963560713, 39022.60977390218, 39054.60945390538, 3464.359093567673, 3468.7745296555895, 3476.548048753671, 3492.231709024011, 3496.877609283663, 30439.0, 30588.8470557648, 30761.846190769127, 30781.076567703003, 30808.229794255098, 4642.048380082075, 4682.859514214579, 4691.437027556715, 4691.460482044575, 4790.305405716186, 187538.06230968758, 188571.0, 189833.0, 190134.0, 190373.0, 48690.513094869304, 48775.756121219165, 49202.753986229836, 49264.75367623139, 49404.0, 50109.49890501121, 50370.74814625904, 50427.74786126046, 50494.74752626213, 50644.74677626662, 13645.249511276777, 13879.51421700256, 13931.930340348234, 13940.442382304796, 13961.581152565439, 9554.713358599114, 9700.175485083846, 10996.560137594566, 11111.444427778579, 11120.110391168688, 14295.07082039664, 14510.637234069021, 14519.92740036293, 14580.85419145795, 14638.0, 5721.170430287668, 5820.738066787005, 5829.446202610745, 5894.322152952465, 5909.881802363929, 976.3995142987154, 981.5092453773113, 1005.492226425665, 1008.2841182760176, 1019.3221507697447, 22122.889385552968, 22175.334739957827, 22538.774612253994, 22982.816632419894, 23319.88340058323, 1034.7620047389144, 1063.9946800266105, 1099.263493459384, 1106.280917403694, 1119.3787447966295, 11747.765044699057, 11879.76240475203, 12072.818907716392, 12114.697132571757, 12186.0, 219414.0, 219858.0, 219978.0, 220395.0, 221274.0, 52216.0, 52571.21143182855, 52888.73555632274, 52916.0, 52925.735371322895, 1417.8723914847712, 1445.4724025730532, 1466.5527014260754, 1471.529110684592, 1472.521430535059, 22263.332100037023, 22523.43691407728, 22644.207452739076, 22867.885660571592, 23197.0, 50723.492765071875, 51588.74205629098, 51996.74001629968, 52004.47995519996, 52019.73990130025, 199774.0, 201875.0, 202644.0, 202799.0, 203334.0, 29913.551296730133, 32181.678183218806, 33579.66420335766, 33839.0, 33864.0, 43383.13233735244, 43566.56433435625, 44342.33486497641, 44482.0, 45027.0, 28011.859940700982, 28050.2987425316, 28101.156965291073, 28511.572326415535, 28817.7118228815, 26570.734292656827, 27330.0, 28505.28736781514, 29267.853660731562, 29802.70197298086, 37381.62618373781, 37412.25175496529, 37952.0, 38096.23807523889, 38349.0, 32289.51565726563, 32663.0, 32673.836630817645, 33068.66931330656, 33111.50332744962, 23661.763382365956, 24536.631950521114, 24951.126710565044, 25256.873715631304, 25327.860246288594], "value": 16933.174030986993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1345920552745, 567.6707509644407, 568.5423234296389, 581.9679917604532, 583.64106074764, 22279.331620051405, 22778.31665050051, 23020.539589208205, 23162.42093947648, 23198.072077116914, 25353.0, 25882.870585647044, 25916.96332146712, 25937.351566210808, 26074.348141296476, 6245.875082498347, 6416.262129855079, 6438.710258038376, 6441.967790161066, 6443.194600674916, 5830.5044071254, 6319.842003949915, 6328.778492752755, 6345.111684364193, 6377.808665740035, 6305.684715764216, 6313.084602732601, 6320.273168585625, 6333.904991425133, 6344.080108384282, 6287.276963149251, 6317.399847014526, 6320.905186422207, 6349.1428657131155, 6358.87282254357, 5858.297004359461, 5912.054071348563, 5916.349201587822, 5921.348651648315, 5923.526117910556, 29343.0, 29920.40159196804, 30210.0, 30536.083917482512, 30632.54051189234, 1888.376835644234, 1934.6711059119984, 1943.523836660013, 1945.8443324534144, 1946.562023544691, 18953.715694264596, 19591.706124408145, 19616.509587260432, 19637.705434418494, 19639.901800490905, 2279.908803647852, 2288.588054150269, 2335.135999680112, 2335.311083230451, 2388.4625959159052, 133785.33107334498, 136354.0, 136492.0, 136899.31550342284, 137932.0, 14142.787858182135, 14744.0, 15117.319720612599, 15233.095863017123, 15541.0, 24153.879230603736, 24200.51598968046, 24201.63697544538, 24262.393440164138, 24275.39311517226, 9750.414975101517, 9874.802503950024, 10116.949415253024, 10131.189504839595, 10142.29003969715, 9045.638174472948, 9123.680671176477, 9138.314626403046, 9147.313951453667, 9230.953845230864, 7561.395088392916, 8939.329550283755, 9118.680846170351, 9240.722778316662, 9333.0, 2670.5193065248054, 2686.6641669791275, 2695.5417579011614, 2708.6614173228345, 2748.993449313217, 825.9050209226016, 856.3277826905849, 863.404251066762, 865.2904618213005, 869.0527325215419, 18347.63304733898, 18541.721874171897, 18548.536286592942, 18603.44189674312, 20336.898315508624, 900.6847603338779, 914.7347269291964, 950.2825366848124, 957.4686049242737, 964.6623681711485, 9740.928497865229, 9825.4104753715, 10020.0, 10370.259331434478, 10846.45767711627, 463898.0, 480631.0, 492485.0, 518505.0, 573874.0, 122007.38996304962, 124163.0, 128912.0, 129467.35266323609, 129861.35069324593, 1181.9763604727857, 1209.3711270139654, 1251.8059700746398, 1252.6743046807712, 1254.5107408110844, 20058.699119512927, 20612.381628551168, 21151.153953841673, 21584.02871870738, 22656.320310390714, 59991.0, 61905.07142392958, 62442.0, 62447.0, 64226.03660944996, 73977.6301118491, 74461.6276918612, 74742.0, 74896.25103748892, 75552.0, 14493.420263189777, 15367.077975321516, 15461.613459663598, 15467.071975681494, 15484.380624774883, 21301.46746331292, 21384.358469245948, 21391.25130620421, 23893.40266493282, 24161.63757543603, 19013.14440850193, 19171.233150673816, 19238.326658566883, 19381.806181938566, 19383.321583744502, 14194.787078193629, 14339.569812905629, 14452.205128718022, 15199.088054716753, 15247.618809529407, 18566.907165464087, 19506.80493195107, 19820.70268945996, 19890.403287901387, 20041.599168016848, 15014.174220417983, 15053.548393548212, 15070.472533461276, 15180.544583662508, 15329.233538322816, 18699.813001870352, 18882.0, 18918.3378581749, 19018.904905475385, 19228.423147305602], "value": 11940.426590957908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.5187908292555, 1421.296458253165, 1422.7154569086179, 1435.382785402278, 1435.7272118297524, 13501.0, 13698.931505342483, 14127.152370857755, 14167.858321416783, 14170.078944868575, 14208.644783880409, 14503.347349369278, 14506.129632222048, 14518.201498917582, 14542.054766440175, 2653.4958357911937, 2698.608701738247, 2713.4980028694654, 2719.0891051497774, 2720.442309326593, 2569.383347996477, 2661.5076210900947, 2700.9189724308203, 2707.7292270772964, 2709.796765242605, 2640.0891692366104, 2673.70589235184, 2686.825356351831, 2723.3872378714827, 2734.4804487147476, 2582.2769624505167, 2601.2586412872333, 2624.895004199839, 2628.7239839816925, 2632.0393056534226, 2591.676040494938, 2610.451805120908, 2625.77680897124, 2626.645402870607, 2629.53983052965, 13477.05660603758, 13776.10455320401, 13777.655558611015, 13777.793333099911, 13788.793168102486, 7174.461915356317, 7392.963035184844, 7420.0, 7422.703091876372, 7431.516951398142, 4895.461499235082, 4977.6764510307075, 5030.144875371196, 5158.3552055993005, 5178.97410512945, 1678.6474840283556, 1682.1589205397302, 1722.5951901303183, 1732.9480115596552, 1741.8867773594802, 22668.88665556678, 22880.199193028166, 22897.198598048988, 22910.083596656114, 22917.77082229173, 6145.985912324506, 6407.935920640827, 6514.0, 6579.47364210862, 6598.637074960923, 15365.769513457308, 15403.691926161415, 15466.767998480032, 15481.922590386976, 15502.224888755518, 7051.647417629098, 7327.5969821659255, 7337.046183996046, 7344.926550734531, 7349.522281051714, 5434.538064264581, 6177.567570270128, 6725.226598941184, 6731.697073631698, 6897.310268973163, 5351.117065684196, 5496.340439147328, 5546.805861794898, 5558.526990347561, 5631.070873305859, 1690.5013021158788, 1735.644192940444, 1744.2586900567462, 1758.085795386392, 1767.2665843674988, 850.732019413895, 859.5272600069936, 869.6130222051127, 898.2813749000774, 914.4696076275744, 6659.267480577133, 6894.620795856276, 6972.372486476242, 7017.92982070183, 7072.964635176894, 719.8092505486051, 725.7858931615186, 729.956202627844, 732.5421611492817, 744.5644298085572, 4319.4816622005565, 4688.109259240733, 4836.540528649773, 4889.804407823718, 5253.605979551549, 19010.71483927742, 19443.22227110928, 19449.8055019448, 19485.220591176196, 19601.411957641292, 17984.460466186036, 18945.90527047356, 18972.335968241045, 19027.953462559693, 19040.52398690044, 10397.740056498647, 10414.448460127318, 10757.408342541235, 10768.676939691823, 10845.078168355778, 7200.927990720235, 7468.589227592534, 7546.66040028189, 7920.287174154354, 8046.436749427484, 15840.207989600704, 16040.518784436486, 16346.346146154021, 16385.42651007209, 16426.589335266715, 13167.868321316664, 15932.36270549165, 16253.0, 16317.347306107622, 17238.0, 10132.44271565071, 10984.340939543654, 11078.667639970814, 11089.112870970464, 11110.61112861046, 12748.171368860994, 12943.676408089874, 13025.544105956626, 13043.804342934674, 13050.086493945333, 9738.610455581698, 9859.654912078044, 10201.795964080527, 10350.0, 10599.0, 9497.184511336505, 9866.851997219905, 9899.257555683209, 10008.899911000797, 10284.228682848667, 8917.0, 8947.955260223918, 8977.057408971963, 9063.954680226556, 9087.409318394548, 6448.419642232222, 6833.2483426824, 6847.315268473113, 6933.687984040629, 6949.513534052568, 6253.624782513064, 6425.5502114851515, 6784.559003664746, 6848.623325717133, 6889.379955804002], "value": 6188.310803004321, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.1342324086367, 496.17387050560797, 521.7938914128918, 524.6982984783746, 534.0200731657409, 6203.255609326881, 6237.750489980407, 6278.717457714408, 6329.303776584572, 6340.270868850083, 5997.3416216108135, 6052.939470605293, 6113.663748493831, 6124.173236613055, 6194.3805619438035, 4995.475475075119, 4998.750062496879, 5005.874853128665, 5020.824271150511, 5055.772490237939, 4969.527894850002, 4989.700617962916, 4996.1756310208775, 5021.472745361721, 5031.84904452867, 4672.929906051412, 4872.6345524085655, 4889.926651100236, 4899.436564795059, 4940.530649588283, 4890.95109048912, 4897.951020489803, 4903.485134060944, 4910.410750709902, 4980.327655766461, 4380.759058251795, 4412.845550405753, 4470.463544374663, 4486.820527178941, 4490.663200259994, 6057.3639767824625, 6065.727042283063, 6103.542234332398, 6154.692265386713, 6189.350118237565, 5764.106563482667, 5768.673205162836, 5768.990426675357, 5769.798057067983, 5776.97111514444, 6518.217813862319, 6541.640209788459, 6542.509311801634, 6552.836179095513, 6583.242927063401, 4846.418429788413, 4872.244802055687, 4879.097366987119, 4881.780319885614, 4896.36347274852, 6814.557053791537, 6922.757703480354, 6968.094147760809, 6974.302569743036, 7012.614306213156, 4893.7063776173545, 4947.604191664658, 4952.8761780955765, 4953.801847926043, 4989.501049894981, 4961.2558116282125, 4995.650304478651, 5000.224965130411, 5017.37282839645, 5044.486654003857, 5562.554995600342, 5612.663240205601, 5680.630759000652, 5698.202251684767, 5741.7990370337675, 6531.477481801445, 6560.573562718408, 6579.407853293226, 6594.9670251649395, 6597.439217666552, 1662.2602941690832, 1698.244281294812, 1738.330742664058, 1752.649470105984, 1764.8941063535972, 1203.1096988228649, 1210.328267811373, 1224.3878060969516, 1235.6169587427926, 1253.0852477691337, 5705.572082093777, 5742.253507044057, 5813.244278243886, 5845.9707701462075, 5850.3564607893095, 6523.7716679915975, 6591.703373348115, 6666.333416645839, 6669.0, 6711.865762684719, 5681.687507187145, 5693.658380497183, 5705.343885453226, 5776.42235776419, 5819.592628515963, 3561.679448849616, 3582.390993531106, 3615.1865830188, 3627.4014787560286, 3656.2870240302886, 6525.249596296392, 6538.640374779433, 6541.607503549707, 6563.50773691975, 6613.735450582019, 6835.453163746988, 6860.451163906875, 6870.931290687129, 6891.552049116792, 6929.792106236821, 6390.329015453496, 6466.385693359123, 6475.255345635218, 6552.246491653425, 6559.573627714183, 6634.436072933855, 6684.6991885364305, 6706.497012724163, 6710.932890671031, 6762.715084133999, 6602.3397660233595, 6608.240052394036, 6635.6350400728425, 6695.263521012587, 6778.779819632514, 6488.318726533646, 6564.4420224281475, 6583.539152259296, 6647.135872336566, 6653.767118151035, 4942.135126352946, 4959.504049595012, 4994.775235114501, 5021.096202683552, 5050.949490505048, 6739.865202695821, 6780.220274668476, 6802.217744959393, 6808.148981377328, 6837.726490940307, 6382.20222472191, 6470.094186813756, 6498.545101842826, 6509.316521765147, 6610.702518386588, 6427.839304017437, 6473.579217350857, 6498.252700939453, 6513.576617519846, 6564.376384243489, 6131.877362452637, 6230.906536401867, 6366.376573973792, 6399.55203135776, 6482.319356467503, 6277.30949595535, 6481.5786973848435, 6541.803745887631, 6555.836104097245, 6568.638724870178, 6286.968565157145, 6344.30212676596, 6347.809565713036, 6416.230052393743, 6416.363827224028], "value": 5046.71329876515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.2364989758704, 903.494043335732, 910.804177101923, 911.3529394130168, 921.3550514639754, 16618.08600526972, 17351.305947762074, 17352.739708904362, 17368.13159342031, 20268.087936042877, 19620.275282946313, 19745.901270493665, 19758.209671613153, 19804.207831686752, 19892.9005354973, 960.4141473701037, 1038.8026275007762, 1039.8960103989577, 1043.8382050782102, 1045.0751085289498, 1043.9217058720587, 1047.9214058945572, 1049.979000419991, 1053.210092430677, 1053.3890343600692, 777.4208214879923, 790.9802254943644, 1026.3277553202665, 1074.693712291997, 1078.1751959750798, 1058.534244932231, 1062.1237479079753, 1063.4044934836477, 1067.754416484213, 1067.8291473364225, 778.0624347661055, 778.8909552662575, 782.5148407987084, 784.705735349244, 785.7524879662946, 19131.0, 19690.31083912056, 19870.205191792313, 19971.101300441514, 20113.79886201134, 20207.898960505252, 20484.897575512026, 20855.270065547633, 20885.582288354148, 21233.787662123337, 15313.0, 15520.068795872285, 15526.922365388215, 15563.299651515708, 15859.762103568455, 3571.8928432146818, 3612.060864175307, 3614.8554057837655, 3616.529851119364, 3622.0, 117325.41337293344, 119599.0, 121666.0, 121790.0, 125150.37424812908, 16132.435364762177, 16737.665246694996, 16761.91619041897, 16769.496915092568, 16785.0, 29905.0, 30172.0, 30259.848700756356, 30275.243118922204, 30322.0, 8228.794280143044, 8639.265662418638, 8754.387192896564, 8778.385513014027, 8874.156955089256, 4103.117829666636, 4210.831566737357, 4221.155768846243, 4236.428082208924, 4245.257080011047, 5591.440855914458, 5664.688442135722, 5707.743151558107, 5763.0202865512965, 5765.250517432707, 1016.5781200801584, 1045.7699306152786, 1049.2655141400896, 1062.3678911047914, 1063.2025980514613, 644.2269276867777, 650.5933791380387, 658.5324419661998, 695.422799076765, 700.4851434195862, 11499.540018399337, 12162.756744865053, 12708.364581770875, 12828.35858207086, 13046.347682615831, 645.3030726815028, 651.8142329436088, 656.255150404285, 664.2228592546732, 664.833791552112, 5362.892742145214, 5383.67697938125, 5466.753996070107, 5491.862703432446, 5669.858253543612, 96925.51537242268, 100714.91421029523, 101528.0, 102509.48745256376, 104627.0, 87640.5617971906, 92359.53820230855, 92657.0, 93559.0, 93890.53054734683, 74830.62584687151, 79109.0, 79525.60237198777, 80730.0, 80918.22811761247, 12161.0, 12398.0, 12445.875541244472, 12831.037672174438, 12929.741405172032, 32575.837120814245, 33235.50146747849, 34149.82925085458, 34903.82548087243, 35411.0, 40615.0, 41959.0, 43007.0, 43699.78150109229, 44519.77740111409, 17873.106344682456, 18203.908980455013, 18368.54078647991, 18564.350247741266, 18595.907020464812, 19943.60112797765, 20141.39575812728, 20682.27612033632, 20803.79196208079, 21113.472163196042, 18169.909150454165, 18771.718424223374, 18787.06064696787, 19094.522636934187, 19155.425337239903, 17536.82463175352, 17709.20308586091, 18066.36767713124, 19682.80317196867, 19702.21191152338, 19174.808251917304, 19244.711329330352, 19770.50573735668, 19987.400377988684, 20013.59972800565, 12096.576619818265, 12274.509019639114, 12418.75162496763, 12764.106512544033, 12865.742685146432, 13012.28432436225, 13716.177029378268, 13917.652058698613, 14732.55802325932, 15099.622509437351], "value": 8902.351151113906, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 104.0, 108.0, 108.0, 110.0, 108.0, 102.0, 108.0, 109.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 140.0, 177.0, 121.0, 143.0, 148.0, 123.0, 168.0, 119.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 161.0, 163.0, 163.0, 165.0, 171.0, 167.0, 172.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 182.0, 77.0, 76.0, 81.0, 79.0, 162.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 139.0, 79.0, 78.0, 80.0, 125.0, 79.0, 78.0, 137.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 114.0, 117.0, 117.0, 120.0, 115.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 153.0, 158.0, 151.0, 151.0, 153.0, 150.0, 150.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 101.0, 99.0, 94.0, 94.0, 93.0, 98.0, 96.0, 94.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 62.0, 56.0, 57.0, 55.0, 55.0, 56.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 82.0, 87.0, 88.0, 81.0, 79.0, 89.0, 79.0, 84.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 134.0, 130.0, 130.0, 139.0, 128.0, 136.0, 137.0, 130.0, 168.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 178.0, 180.0, 187.0, 184.0, 185.0, 198.0, 179.0, 199.0], "value": 186.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 70.0, 70.0, 68.0, 66.0, 66.0, 67.0, 67.0], "value": 67.8, "unit": "score"}]}]} 03:19:57 INFO - Return code: 0 03:19:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:19:57 INFO - # TBPL SUCCESS # 03:19:57 INFO - Running post-action listener: _package_coverage_data 03:19:57 INFO - Running post-action listener: _resource_record_post_action 03:19:57 INFO - [mozharness: 2017-07-31 10:19:57.172786Z] Finished run-tests step (success) 03:19:57 INFO - Running post-run listener: _resource_record_post_run 03:19:57 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 339968; Write bytes: 444035072; Read time: 96; Write time: 364980 03:19:57 INFO - TinderboxPrint: CPU usage
13.2% 03:19:57 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 96 03:19:57 INFO - TinderboxPrint: I/O write bytes / time
444,035,072 / 364,980 03:19:57 INFO - TinderboxPrint: CPU idle
8,278.8 (86.8%) 03:19:57 INFO - TinderboxPrint: CPU user
1,207.2 (12.7%) 03:19:57 INFO - TinderboxPrint: Swap in / out
0 / 0 03:19:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120111104; Read time: 0; Write time: 95580 03:19:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:19:57 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 335872; Write bytes: 323923968; Read time: 88; Write time: 269400 03:19:57 INFO - Running post-run listener: _upload_blobber_files 03:19:57 INFO - Blob upload gear active. 03:19:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:57 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:19:57 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:19:57 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:19:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:05 INFO - (blobuploader) - INFO - Done attempting. 03:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:05 INFO - (blobuploader) - INFO - Done attempting. 03:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:06 INFO - (blobuploader) - INFO - Done attempting. 03:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:07 INFO - (blobuploader) - INFO - Done attempting. 03:20:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:07 INFO - Return code: 0 03:20:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143ff92bb358b87dcec0a74dde41e8b3e822d1547ab402757c879087648455bc6b91af864a1c51b429a9ab0e1545c6513e1958053a0dd0549db3532c02eb2965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6da96dd8b8c067ef025641159c47d2891e2f1529da2dd55a6e775fbc8fc03f89ce335654fed4d562a765fa50f243226e0032a98defd4b1042c4ddd0b6cb4215b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e8f1eaaa13383456e90556b20602e3ecf62850f5dc7e1ccbc68d24587e967cec0d05cf164e855d23d375833493def81021d7a6414a9e4df6dd5d189999e89f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1235f9a5f989a876cfe67a3aa83c29e47664192f50ca0e335817b795637011dd70e50795c073050140c30ba914e07853fd362542e1b8ddd7aec0621e54fa8d59"} 03:20:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:07 INFO - Contents: 03:20:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143ff92bb358b87dcec0a74dde41e8b3e822d1547ab402757c879087648455bc6b91af864a1c51b429a9ab0e1545c6513e1958053a0dd0549db3532c02eb2965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6da96dd8b8c067ef025641159c47d2891e2f1529da2dd55a6e775fbc8fc03f89ce335654fed4d562a765fa50f243226e0032a98defd4b1042c4ddd0b6cb4215b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e8f1eaaa13383456e90556b20602e3ecf62850f5dc7e1ccbc68d24587e967cec0d05cf164e855d23d375833493def81021d7a6414a9e4df6dd5d189999e89f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1235f9a5f989a876cfe67a3aa83c29e47664192f50ca0e335817b795637011dd70e50795c073050140c30ba914e07853fd362542e1b8ddd7aec0621e54fa8d59"} 03:20:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:07 INFO - Copying logs to upload dir... 03:20:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.120262 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-07-31 03:20:07.855033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:20:07.859341) ========= 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=32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143ff92bb358b87dcec0a74dde41e8b3e822d1547ab402757c879087648455bc6b91af864a1c51b429a9ab0e1545c6513e1958053a0dd0549db3532c02eb2965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6da96dd8b8c067ef025641159c47d2891e2f1529da2dd55a6e775fbc8fc03f89ce335654fed4d562a765fa50f243226e0032a98defd4b1042c4ddd0b6cb4215b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e8f1eaaa13383456e90556b20602e3ecf62850f5dc7e1ccbc68d24587e967cec0d05cf164e855d23d375833493def81021d7a6414a9e4df6dd5d189999e89f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1235f9a5f989a876cfe67a3aa83c29e47664192f50ca0e335817b795637011dd70e50795c073050140c30ba914e07853fd362542e1b8ddd7aec0621e54fa8d59"} build_url:https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/L9gn2xeTReiDdJK-FxgWPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143ff92bb358b87dcec0a74dde41e8b3e822d1547ab402757c879087648455bc6b91af864a1c51b429a9ab0e1545c6513e1958053a0dd0549db3532c02eb2965", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6da96dd8b8c067ef025641159c47d2891e2f1529da2dd55a6e775fbc8fc03f89ce335654fed4d562a765fa50f243226e0032a98defd4b1042c4ddd0b6cb4215b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2e8f1eaaa13383456e90556b20602e3ecf62850f5dc7e1ccbc68d24587e967cec0d05cf164e855d23d375833493def81021d7a6414a9e4df6dd5d189999e89f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1235f9a5f989a876cfe67a3aa83c29e47664192f50ca0e335817b795637011dd70e50795c073050140c30ba914e07853fd362542e1b8ddd7aec0621e54fa8d59"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:20:08.058954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 03:20:08.059313) ========= 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=32c5991c409366f7fec8a718000001d2-1501489394.640564-1640257237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 1.25 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 03:20:09.310118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:20:09.310452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:20:09.311171) ========= ========= Total master_lag: 1.83 =========