builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1501229313.51 results: success (0) revision: 5845151f1a2cd00957fdd48e204542ccbdfaba1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.509569) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.510198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.510481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.553837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.554107) ========= 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=781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 01:08:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.1M=0s 2017-07-28 01:08:34 (24.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212296 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.784473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.787787) ========= 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=781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019272 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.837217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:33.837513) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5845151f1a2cd00957fdd48e204542ccbdfaba1e --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 5845151f1a2cd00957fdd48e204542ccbdfaba1e --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=781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 01:08:34,717 truncating revision to first 12 chars 2017-07-28 01:08:34,717 Setting DEBUG logging. 2017-07-28 01:08:34,717 attempt 1/10 2017-07-28 01:08:34,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5845151f1a2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-28 01:08:35,002 unpacking tar archive at: mozilla-central-5845151f1a2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614819 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:34.468793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:34.469094) ========= script_repo_revision: 5845151f1a2cd00957fdd48e204542ccbdfaba1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:34.469478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:34.472953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:34.484279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-28 01:08:34.484543) ========= /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=781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:35 INFO - MultiFileLogger online at 20170728 01:08:35 in /builds/slave/test 01:08:35 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 01:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:08:35 INFO - {'append_to_log': False, 01:08:35 INFO - 'base_work_dir': '/builds/slave/test', 01:08:35 INFO - 'blob_upload_branch': 'Firefox', 01:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:08:35 INFO - 'branch': 'Firefox', 01:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:35 INFO - 'code_coverage': False, 01:08:35 INFO - 'config_files': ('talos/linux_config.py',), 01:08:35 INFO - 'default_actions': ('clobber', 01:08:35 INFO - 'read-buildbot-config', 01:08:35 INFO - 'download-and-extract', 01:08:35 INFO - 'populate-webroot', 01:08:35 INFO - 'create-virtualenv', 01:08:35 INFO - 'install', 01:08:35 INFO - 'setup-mitmproxy', 01:08:35 INFO - 'run-tests'), 01:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:35 INFO - 'disable_ccov_upload': False, 01:08:35 INFO - 'download_minidump_stackwalk': True, 01:08:35 INFO - 'download_symbols': 'ondemand', 01:08:35 INFO - 'enable_stylo': False, 01:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:35 INFO - 'gecko_profile': False, 01:08:35 INFO - 'gecko_profile_interval': 0, 01:08:35 INFO - 'installer_path': 'installer.exe', 01:08:35 INFO - 'log_level': 'info', 01:08:35 INFO - 'log_name': 'talos', 01:08:35 INFO - 'log_to_console': True, 01:08:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:35 INFO - 'opt_config_files': (), 01:08:35 INFO - 'pip_index': False, 01:08:35 INFO - 'suite': 'dromaeojs-e10s', 01:08:35 INFO - 'system_bits': '32', 01:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:35 INFO - 'title': 'talos-linux64-ix-080', 01:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:35 INFO - 'use_talos_json': True, 01:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:35 INFO - 'work_dir': 'build'} 01:08:35 INFO - [mozharness: 2017-07-28 08:08:35.594723Z] Running clobber step. 01:08:35 INFO - Running pre-action listener: _resource_record_pre_action 01:08:35 INFO - Running main action method: clobber 01:08:35 INFO - rmtree: /builds/slave/test/build 01:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:36 INFO - Running post-action listener: _resource_record_post_action 01:08:36 INFO - [mozharness: 2017-07-28 08:08:36.569905Z] Finished clobber step (success) 01:08:36 INFO - [mozharness: 2017-07-28 08:08:36.570007Z] Running read-buildbot-config step. 01:08:36 INFO - Running pre-action listener: _resource_record_pre_action 01:08:36 INFO - Running main action method: read_buildbot_config 01:08:36 INFO - Using buildbot properties: 01:08:36 INFO - { 01:08:36 INFO - "project": "", 01:08:36 INFO - "product": "firefox", 01:08:36 INFO - "who": "cbook@mozilla.com", 01:08:36 INFO - "installer_path": "public/build/target.tar.bz2", 01:08:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 01:08:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 01:08:36 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 01:08:36 INFO - "stage_platform": "linux64-stylosequential", 01:08:36 INFO - "basedir": "/builds/slave/test", 01:08:36 INFO - "buildnumber": 127, 01:08:36 INFO - "platform": "ubuntu64_hw_styloseq", 01:08:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:08:36 INFO - "slavebuilddir": "test", 01:08:36 INFO - "taskId": "I6ODOQ0OSyWZaHacLlIQIQ", 01:08:36 INFO - "branch": "mozilla-central", 01:08:36 INFO - "script_repo_revision": "production", 01:08:36 INFO - "revision": "5845151f1a2cd00957fdd48e204542ccbdfaba1e", 01:08:36 INFO - "slavename": "talos-linux64-ix-080", 01:08:36 INFO - "repo_path": "mozilla-central" 01:08:36 INFO - } 01:08:36 INFO - Finding installer, test and symbols from parent task. 01:08:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I6ODOQ0OSyWZaHacLlIQIQ'}, attempt #1 01:08:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I6ODOQ0OSyWZaHacLlIQIQ'}, attempt #1 01:08:37 INFO - Task dependencies: Q_0oAkbmSxa4brTQ_KIZPg 01:08:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg'}, attempt #1 01:08:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:08:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/test_packages.json 01:08:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip 01:08:37 INFO - Running post-action listener: _resource_record_post_action 01:08:37 INFO - [mozharness: 2017-07-28 08:08:37.894921Z] Finished read-buildbot-config step (success) 01:08:37 INFO - [mozharness: 2017-07-28 08:08:37.895143Z] Running download-and-extract step. 01:08:37 INFO - Running pre-action listener: _resource_record_pre_action 01:08:37 INFO - Running main action method: download_and_extract 01:08:37 INFO - mkdir: /builds/slave/test/build/tests 01:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:37 INFO - trying https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json 01:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:08:38 INFO - Downloaded 989 bytes. 01:08:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:08:38 INFO - Using the following test package requirements: 01:08:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:08:38 INFO - u'common': [u'target.common.tests.zip'], 01:08:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:08:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:08:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:08:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:08:38 INFO - u'mozbase': [u'target.common.tests.zip'], 01:08:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:08:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:08:38 INFO - u'web-platform': [u'target.common.tests.zip', 01:08:38 INFO - u'target.web-platform.tests.tar.gz'], 01:08:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:08:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:08:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip 01:08:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:08:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip into memory 01:08:39 INFO - Content-Length response header: 72561179 01:08:39 INFO - Bytes received: 72561179 01:08:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:08:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip 01:08:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:08:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip into memory 01:08:52 INFO - Content-Length response header: 72561179 01:08:52 INFO - Bytes received: 72561179 01:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip 01:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip into memory 01:09:07 INFO - Content-Length response header: 14496465 01:09:07 INFO - Bytes received: 14496465 01:09: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')]} 01:09:07 INFO - trying https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:09:08 INFO - Downloaded 62069301 bytes. 01:09:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:08 INFO - mkdir: /builds/slave/test/properties 01:09:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:09:08 INFO - Writing to file /builds/slave/test/properties/build_url 01:09:08 INFO - Contents: 01:09:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:09:08 INFO - Running post-action listener: _resource_record_post_action 01:09:08 INFO - Running post-action listener: set_extra_try_arguments 01:09:08 INFO - [mozharness: 2017-07-28 08:09:08.660359Z] Finished download-and-extract step (success) 01:09:08 INFO - [mozharness: 2017-07-28 08:09:08.660458Z] Running populate-webroot step. 01:09:08 INFO - Running pre-action listener: _resource_record_pre_action 01:09:08 INFO - Running main action method: populate_webroot 01:09:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:09:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:09:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:09:08 INFO - 'tests': ['damp', 'tps']}, 01:09:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:09:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:09:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:09:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:09:08 INFO - 'other-e10s': {'tests': ['a11yr', 01:09:08 INFO - 'ts_paint', 01:09:08 INFO - 'tpaint', 01:09:08 INFO - 'sessionrestore', 01:09:08 INFO - 'sessionrestore_many_windows', 01:09:08 INFO - 'sessionrestore_no_auto_restore', 01:09:08 INFO - 'tabpaint']}, 01:09:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 01:09:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 01:09:08 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:09:08 INFO - 'talos_options': ['--mitmproxy', 01:09:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:09:08 INFO - '--firstNonBlankPaint'], 01:09:08 INFO - 'tests': ['quantum_pageload_google', 01:09:08 INFO - 'quantum_pageload_youtube', 01:09:08 INFO - 'quantum_pageload_amazon', 01:09:08 INFO - 'quantum_pageload_facebook']}, 01:09:08 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:09:08 INFO - 'talos_options': ['--stylo', 01:09:08 INFO - '--mitmproxy', 01:09:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:09:08 INFO - '--firstNonBlankPaint'], 01:09:08 INFO - 'tests': ['quantum_pageload_google', 01:09:08 INFO - 'quantum_pageload_youtube', 01:09:08 INFO - 'quantum_pageload_amazon', 01:09:08 INFO - 'quantum_pageload_facebook']}, 01:09:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:09:08 INFO - 'tsvgr_opacity', 01:09:08 INFO - 'tart', 01:09:08 INFO - 'tscrollx', 01:09:08 INFO - 'cart', 01:09:08 INFO - 'tsvg_static']}, 01:09:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:09:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:09:08 INFO - 'talos_options': ['--xperf_path', 01:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:08 INFO - 'tests': ['tp5n']}}} 01:09:08 INFO - Running post-action listener: _resource_record_post_action 01:09:08 INFO - [mozharness: 2017-07-28 08:09:08.667877Z] Finished populate-webroot step (success) 01:09:08 INFO - [mozharness: 2017-07-28 08:09:08.667967Z] Running create-virtualenv step. 01:09:08 INFO - Running pre-action listener: _resource_record_pre_action 01:09:08 INFO - Running main action method: create_virtualenv 01:09:08 INFO - Creating virtualenv /builds/slave/test/build/venv 01:09:08 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 01:09:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:09:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 01:09:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:09:08 INFO - Using real prefix '/usr' 01:09:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:09:09 INFO - Installing distribute.............................................................................................................................................................................................done. 01:09:11 INFO - Installing pip.................done. 01:09:11 INFO - Return code: 0 01:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:09:11 INFO - Reading from file tmpfile_stdout 01:09:11 INFO - Output received: 01:09:11 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) 01:09:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:11 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:11 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 01:09:11 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 01:09:11 INFO - Using env: {'DISPLAY': ':0', 01:09:11 INFO - 'HOME': '/home/cltbld', 01:09:11 INFO - 'LANG': 'en_US.UTF-8', 01:09:11 INFO - 'LANGUAGE': 'en_US:en', 01:09:11 INFO - 'LOGNAME': 'cltbld', 01:09:11 INFO - 'MAIL': '/var/mail/cltbld', 01:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:11 INFO - 'MOZ_NO_REMOTE': '1', 01:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:11 INFO - 'NO_EM_RESTART': '1', 01:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:11 INFO - 'PWD': '/builds/slave/test', 01:09:11 INFO - 'SHELL': '/bin/bash', 01:09:11 INFO - 'SHLVL': '1', 01:09:11 INFO - 'TERM': 'linux', 01:09:11 INFO - 'TMOUT': '86400', 01:09:11 INFO - 'USER': 'cltbld', 01:09:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:11 INFO - '_': '/tools/buildbot/bin/python'} 01:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:11 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 01:09:11 INFO - Cleaning up... 01:09:11 INFO - Return code: 0 01:09:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:11 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:11 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 01:09:11 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 01:09:11 INFO - Using env: {'DISPLAY': ':0', 01:09:11 INFO - 'HOME': '/home/cltbld', 01:09:11 INFO - 'LANG': 'en_US.UTF-8', 01:09:11 INFO - 'LANGUAGE': 'en_US:en', 01:09:11 INFO - 'LOGNAME': 'cltbld', 01:09:11 INFO - 'MAIL': '/var/mail/cltbld', 01:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:11 INFO - 'MOZ_NO_REMOTE': '1', 01:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:11 INFO - 'NO_EM_RESTART': '1', 01:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:11 INFO - 'PWD': '/builds/slave/test', 01:09:11 INFO - 'SHELL': '/bin/bash', 01:09:11 INFO - 'SHLVL': '1', 01:09:11 INFO - 'TERM': 'linux', 01:09:11 INFO - 'TMOUT': '86400', 01:09:11 INFO - 'USER': 'cltbld', 01:09:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:11 INFO - '_': '/tools/buildbot/bin/python'} 01:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:12 INFO - Downloading/unpacking psutil>=3.1.1 01:09:12 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 01:09:12 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 01:09:12 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 01:09:12 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 01:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:09:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:13 INFO - Installing collected packages: psutil 01:09:13 INFO - Running setup.py install for psutil 01:09:13 INFO - building 'psutil._psutil_linux' extension 01:09:13 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 01:09:14 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 01:09:14 INFO - building 'psutil._psutil_posix' extension 01:09:14 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 01:09:14 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 01:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:14 INFO - Successfully installed psutil 01:09:14 INFO - Cleaning up... 01:09:14 INFO - Return code: 0 01:09:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:09:14 INFO - Using env: {'DISPLAY': ':0', 01:09:14 INFO - 'HOME': '/home/cltbld', 01:09:14 INFO - 'LANG': 'en_US.UTF-8', 01:09:14 INFO - 'LANGUAGE': 'en_US:en', 01:09:14 INFO - 'LOGNAME': 'cltbld', 01:09:14 INFO - 'MAIL': '/var/mail/cltbld', 01:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:14 INFO - 'MOZ_NO_REMOTE': '1', 01:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:14 INFO - 'NO_EM_RESTART': '1', 01:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:14 INFO - 'PWD': '/builds/slave/test', 01:09:14 INFO - 'SHELL': '/bin/bash', 01:09:14 INFO - 'SHLVL': '1', 01:09:14 INFO - 'TERM': 'linux', 01:09:14 INFO - 'TMOUT': '86400', 01:09:14 INFO - 'USER': 'cltbld', 01:09:14 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:14 INFO - '_': '/tools/buildbot/bin/python'} 01:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:09:16 INFO - Installing collected packages: mozsystemmonitor 01:09:16 INFO - Running setup.py install for mozsystemmonitor 01:09:16 INFO - Successfully installed mozsystemmonitor 01:09:16 INFO - Cleaning up... 01:09:16 INFO - Return code: 0 01:09:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:09:16 INFO - Using env: {'DISPLAY': ':0', 01:09:16 INFO - 'HOME': '/home/cltbld', 01:09:16 INFO - 'LANG': 'en_US.UTF-8', 01:09:16 INFO - 'LANGUAGE': 'en_US:en', 01:09:16 INFO - 'LOGNAME': 'cltbld', 01:09:16 INFO - 'MAIL': '/var/mail/cltbld', 01:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:16 INFO - 'MOZ_NO_REMOTE': '1', 01:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:16 INFO - 'NO_EM_RESTART': '1', 01:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:16 INFO - 'PWD': '/builds/slave/test', 01:09:16 INFO - 'SHELL': '/bin/bash', 01:09:16 INFO - 'SHLVL': '1', 01:09:16 INFO - 'TERM': 'linux', 01:09:16 INFO - 'TMOUT': '86400', 01:09:16 INFO - 'USER': 'cltbld', 01:09:16 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:16 INFO - '_': '/tools/buildbot/bin/python'} 01:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:16 INFO - Downloading/unpacking jsonschema==2.5.1 01:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:17 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:17 INFO - warning: no files found matching '*.txt' 01:09:17 INFO - no previously-included directories found matching 'build' 01:09:17 INFO - no previously-included directories found matching 'dist' 01:09:17 INFO - no previously-included directories found matching '.git*' 01:09:17 INFO - Installing collected packages: jsonschema, functools32 01:09:17 INFO - Running setup.py install for functools32 01:09:17 INFO - warning: no files found matching '*.txt' 01:09:17 INFO - no previously-included directories found matching 'build' 01:09:17 INFO - no previously-included directories found matching 'dist' 01:09:17 INFO - no previously-included directories found matching '.git*' 01:09:17 INFO - Successfully installed jsonschema functools32 01:09:17 INFO - Cleaning up... 01:09:17 INFO - Return code: 0 01:09:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:09:17 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')]} 01:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:17 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')]} 01:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:17 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:17 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 01:09:17 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 01:09:17 INFO - Using env: {'DISPLAY': ':0', 01:09:17 INFO - 'HOME': '/home/cltbld', 01:09:17 INFO - 'LANG': 'en_US.UTF-8', 01:09:17 INFO - 'LANGUAGE': 'en_US:en', 01:09:17 INFO - 'LOGNAME': 'cltbld', 01:09:17 INFO - 'MAIL': '/var/mail/cltbld', 01:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:17 INFO - 'MOZ_NO_REMOTE': '1', 01:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:17 INFO - 'NO_EM_RESTART': '1', 01:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:17 INFO - 'PWD': '/builds/slave/test', 01:09:17 INFO - 'SHELL': '/bin/bash', 01:09:17 INFO - 'SHLVL': '1', 01:09:17 INFO - 'TERM': 'linux', 01:09:17 INFO - 'TMOUT': '86400', 01:09:17 INFO - 'USER': 'cltbld', 01:09:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:17 INFO - '_': '/tools/buildbot/bin/python'} 01:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:09:18 INFO - Cleaning up... 01:09:18 INFO - Return code: 0 01:09:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09: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')]} 01:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09: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')]} 01:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:18 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:18 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 01:09:18 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 01:09:18 INFO - Using env: {'DISPLAY': ':0', 01:09:18 INFO - 'HOME': '/home/cltbld', 01:09:18 INFO - 'LANG': 'en_US.UTF-8', 01:09:18 INFO - 'LANGUAGE': 'en_US:en', 01:09:18 INFO - 'LOGNAME': 'cltbld', 01:09:18 INFO - 'MAIL': '/var/mail/cltbld', 01:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:18 INFO - 'MOZ_NO_REMOTE': '1', 01:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:18 INFO - 'NO_EM_RESTART': '1', 01:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:18 INFO - 'PWD': '/builds/slave/test', 01:09:18 INFO - 'SHELL': '/bin/bash', 01:09:18 INFO - 'SHLVL': '1', 01:09:18 INFO - 'TERM': 'linux', 01:09:18 INFO - 'TMOUT': '86400', 01:09:18 INFO - 'USER': 'cltbld', 01:09:18 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:18 INFO - '_': '/tools/buildbot/bin/python'} 01:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:18 INFO - Downloading/unpacking blobuploader==1.2.4 01:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:19 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:19 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 01:09:19 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 01:09:19 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 01:09:19 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 01:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:09:19 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 01:09:19 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 01:09:19 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 01:09:19 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 01:09:19 INFO - Downloading docopt-0.6.1.tar.gz 01:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:20 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:20 INFO - Running setup.py install for blobuploader 01:09:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:20 INFO - Running setup.py install for requests 01:09:20 INFO - Running setup.py install for docopt 01:09:20 INFO - Successfully installed blobuploader requests docopt 01:09:20 INFO - Cleaning up... 01:09:20 INFO - Return code: 0 01:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:20 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')]} 01:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:20 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')]} 01:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:20 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:20 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 01:09:20 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 01:09:20 INFO - Using env: {'DISPLAY': ':0', 01:09:20 INFO - 'HOME': '/home/cltbld', 01:09:20 INFO - 'LANG': 'en_US.UTF-8', 01:09:20 INFO - 'LANGUAGE': 'en_US:en', 01:09:20 INFO - 'LOGNAME': 'cltbld', 01:09:20 INFO - 'MAIL': '/var/mail/cltbld', 01:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:20 INFO - 'MOZ_NO_REMOTE': '1', 01:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:20 INFO - 'NO_EM_RESTART': '1', 01:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:20 INFO - 'PWD': '/builds/slave/test', 01:09:20 INFO - 'SHELL': '/bin/bash', 01:09:20 INFO - 'SHLVL': '1', 01:09:20 INFO - 'TERM': 'linux', 01:09:20 INFO - 'TMOUT': '86400', 01:09:20 INFO - 'USER': 'cltbld', 01:09:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:20 INFO - '_': '/tools/buildbot/bin/python'} 01:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:20 INFO - Running setup.py (path:/tmp/pip-0cytP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:20 INFO - Running setup.py (path:/tmp/pip-yCFOMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:20 INFO - Running setup.py (path:/tmp/pip-iaGH0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:21 INFO - Running setup.py (path:/tmp/pip-TvZcDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:21 INFO - Running setup.py (path:/tmp/pip-GHleHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:21 INFO - Running setup.py (path:/tmp/pip-vWBCHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:21 INFO - Running setup.py (path:/tmp/pip-LKJW5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:21 INFO - Running setup.py (path:/tmp/pip-YUIdF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:21 INFO - Running setup.py (path:/tmp/pip-f3XXWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:21 INFO - Running setup.py (path:/tmp/pip-bDJbqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:21 INFO - Running setup.py (path:/tmp/pip-Qqx63k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:21 INFO - Running setup.py (path:/tmp/pip-MwESaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:21 INFO - Running setup.py (path:/tmp/pip-5tWIcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:21 INFO - Running setup.py (path:/tmp/pip-42Hd_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:21 INFO - Running setup.py (path:/tmp/pip-PG2qdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:21 INFO - Running setup.py (path:/tmp/pip-DV3FsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:21 INFO - Running setup.py (path:/tmp/pip-1S8Yj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:22 INFO - Running setup.py install for manifestparser 01:09:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Running setup.py install for mozcrash 01:09:22 INFO - Running setup.py install for mozdebug 01:09:22 INFO - Running setup.py install for mozdevice 01:09:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Running setup.py install for mozfile 01:09:22 INFO - Running setup.py install for mozhttpd 01:09:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Running setup.py install for mozinfo 01:09:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Running setup.py install for mozInstall 01:09:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:22 INFO - Running setup.py install for mozleak 01:09:22 INFO - Running setup.py install for mozlog 01:09:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Running setup.py install for moznetwork 01:09:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Running setup.py install for mozprocess 01:09:23 INFO - Running setup.py install for mozprofile 01:09:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Running setup.py install for mozrunner 01:09:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Running setup.py install for mozscreenshot 01:09:23 INFO - Running setup.py install for moztest 01:09:23 INFO - Running setup.py install for mozversion 01:09:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:23 INFO - Cleaning up... 01:09:23 INFO - Return code: 0 01:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:23 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')]} 01:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:23 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')]} 01:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:23 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:23 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 01:09:23 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 01:09:23 INFO - Using env: {'DISPLAY': ':0', 01:09:23 INFO - 'HOME': '/home/cltbld', 01:09:23 INFO - 'LANG': 'en_US.UTF-8', 01:09:23 INFO - 'LANGUAGE': 'en_US:en', 01:09:23 INFO - 'LOGNAME': 'cltbld', 01:09:23 INFO - 'MAIL': '/var/mail/cltbld', 01:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:23 INFO - 'MOZ_NO_REMOTE': '1', 01:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:23 INFO - 'NO_EM_RESTART': '1', 01:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:23 INFO - 'PWD': '/builds/slave/test', 01:09:23 INFO - 'SHELL': '/bin/bash', 01:09:23 INFO - 'SHLVL': '1', 01:09:23 INFO - 'TERM': 'linux', 01:09:23 INFO - 'TMOUT': '86400', 01:09:23 INFO - 'USER': 'cltbld', 01:09:23 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:23 INFO - '_': '/tools/buildbot/bin/python'} 01:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:24 INFO - Running setup.py (path:/tmp/pip-aIkcqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:24 INFO - Running setup.py (path:/tmp/pip-TrWTUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:24 INFO - Running setup.py (path:/tmp/pip-yDVY0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:24 INFO - Running setup.py (path:/tmp/pip-bCUse7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:24 INFO - Running setup.py (path:/tmp/pip-mi07X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:24 INFO - Running setup.py (path:/tmp/pip-hnryRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:24 INFO - Running setup.py (path:/tmp/pip-GvjPyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:24 INFO - Running setup.py (path:/tmp/pip-QIonak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:24 INFO - Running setup.py (path:/tmp/pip-KPHny6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:24 INFO - Running setup.py (path:/tmp/pip-vJlflb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:24 INFO - Running setup.py (path:/tmp/pip-z9oW3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:24 INFO - Running setup.py (path:/tmp/pip-Q0cKo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:24 INFO - Running setup.py (path:/tmp/pip-4OCGVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:24 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)) 01:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:24 INFO - Running setup.py (path:/tmp/pip-lXqZg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:25 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)) 01:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:25 INFO - Running setup.py (path:/tmp/pip-da4s6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:25 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)) 01:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:25 INFO - Running setup.py (path:/tmp/pip-xb7LOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:25 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)) 01:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:25 INFO - Running setup.py (path:/tmp/pip-afL6dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:25 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)) 01:09:25 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)) 01:09:25 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)) 01:09:25 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)) 01:09:25 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)) 01:09:25 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)) 01:09:25 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)) 01:09:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:26 INFO - Downloading blessings-1.6.tar.gz 01:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:26 INFO - Installing collected packages: blessings 01:09:26 INFO - Running setup.py install for blessings 01:09:26 INFO - Successfully installed blessings 01:09:26 INFO - Cleaning up... 01:09:26 INFO - Return code: 0 01:09:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:26 INFO - Reading from file tmpfile_stdout 01:09:26 INFO - Current package versions: 01:09:26 INFO - argparse == 1.2.1 01:09:26 INFO - blessings == 1.6 01:09:26 INFO - blobuploader == 1.2.4 01:09:26 INFO - docopt == 0.6.1 01:09:26 INFO - functools32 == 3.2.3-2 01:09:26 INFO - jsonschema == 2.5.1 01:09:26 INFO - manifestparser == 1.1 01:09:26 INFO - mozInstall == 1.13 01:09:26 INFO - mozcrash == 1.0 01:09:26 INFO - mozdebug == 0.1 01:09:26 INFO - mozdevice == 0.51 01:09:26 INFO - mozfile == 1.2 01:09:26 INFO - mozhttpd == 0.7 01:09:26 INFO - mozinfo == 0.10 01:09:26 INFO - mozleak == 0.1 01:09:26 INFO - mozlog == 3.5 01:09:26 INFO - moznetwork == 0.27 01:09:26 INFO - mozprocess == 0.25 01:09:26 INFO - mozprofile == 0.28 01:09:26 INFO - mozrunner == 6.13 01:09:26 INFO - mozscreenshot == 0.1 01:09:26 INFO - mozsystemmonitor == 0.3 01:09:26 INFO - moztest == 0.8 01:09:26 INFO - mozversion == 1.4 01:09:26 INFO - psutil == 3.1.1 01:09:26 INFO - requests == 1.2.3 01:09:26 INFO - wsgiref == 0.1.2 01:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:26 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')]} 01:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:26 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')]} 01:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:26 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:26 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 01:09:26 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 01:09:26 INFO - Using env: {'DISPLAY': ':0', 01:09:26 INFO - 'HOME': '/home/cltbld', 01:09:26 INFO - 'LANG': 'en_US.UTF-8', 01:09:26 INFO - 'LANGUAGE': 'en_US:en', 01:09:26 INFO - 'LOGNAME': 'cltbld', 01:09:26 INFO - 'MAIL': '/var/mail/cltbld', 01:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:26 INFO - 'MOZ_NO_REMOTE': '1', 01:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:26 INFO - 'NO_EM_RESTART': '1', 01:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:26 INFO - 'PWD': '/builds/slave/test', 01:09:26 INFO - 'SHELL': '/bin/bash', 01:09:26 INFO - 'SHLVL': '1', 01:09:26 INFO - 'TERM': 'linux', 01:09:26 INFO - 'TMOUT': '86400', 01:09:26 INFO - 'USER': 'cltbld', 01:09:26 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:26 INFO - '_': '/tools/buildbot/bin/python'} 01:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 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)) 01:09:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:09:27 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 01:09:27 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 01:09:27 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 01:09:27 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 01:09:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:09:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 01:09:28 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 01:09:28 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 01:09:28 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 01:09:28 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 01:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 01:09:28 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)) 01:09:28 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)) 01:09:28 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)) 01:09:28 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)) 01:09:28 INFO - Installing collected packages: marionette-driver, simplejson 01:09:28 INFO - Running setup.py install for marionette-driver 01:09:28 INFO - Running setup.py install for simplejson 01:09:28 INFO - building 'simplejson._speedups' extension 01:09:28 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 01:09:29 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 01:09:29 INFO - Successfully installed marionette-driver simplejson 01:09:29 INFO - Cleaning up... 01:09:29 INFO - Return code: 0 01:09:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:29 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 0x18271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b96d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, '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': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', '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 01:09:29 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 01:09:29 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 01:09:29 INFO - Using env: {'DISPLAY': ':0', 01:09:29 INFO - 'HOME': '/home/cltbld', 01:09:29 INFO - 'LANG': 'en_US.UTF-8', 01:09:29 INFO - 'LANGUAGE': 'en_US:en', 01:09:29 INFO - 'LOGNAME': 'cltbld', 01:09:29 INFO - 'MAIL': '/var/mail/cltbld', 01:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:29 INFO - 'MOZ_NO_REMOTE': '1', 01:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:29 INFO - 'NO_EM_RESTART': '1', 01:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:29 INFO - 'PWD': '/builds/slave/test', 01:09:29 INFO - 'SHELL': '/bin/bash', 01:09:29 INFO - 'SHLVL': '1', 01:09:29 INFO - 'TERM': 'linux', 01:09:29 INFO - 'TMOUT': '86400', 01:09:29 INFO - 'USER': 'cltbld', 01:09:29 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:29 INFO - '_': '/tools/buildbot/bin/python'} 01:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:09:29 INFO - Cleaning up... 01:09:29 INFO - Return code: 0 01:09:29 INFO - Running post-action listener: _resource_record_post_action 01:09:29 INFO - Running post-action listener: _start_resource_monitoring 01:09:29 INFO - Starting resource monitoring. 01:09:29 INFO - [mozharness: 2017-07-28 08:09:29.887763Z] Finished create-virtualenv step (success) 01:09:29 INFO - [mozharness: 2017-07-28 08:09:29.888854Z] Running install step. 01:09:29 INFO - Running pre-action listener: _resource_record_pre_action 01:09:29 INFO - Running main action method: install 01:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:30 INFO - Reading from file tmpfile_stdout 01:09:30 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:30 INFO - Reading from file tmpfile_stdout 01:09:30 INFO - Output received: 01:09:30 INFO - Usage: mozinstall [options] installer 01:09:30 INFO - Options: 01:09:30 INFO - -h, --help show this help message and exit 01:09:30 INFO - -d DEST, --destination=DEST 01:09:30 INFO - Directory to install application into. [default: 01:09:30 INFO - "/builds/slave/test"] 01:09:30 INFO - --app=APP Application being installed. [default: firefox] 01:09:30 INFO - mkdir: /builds/slave/test/build/application 01:09:30 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'] 01:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:09:48 INFO - Reading from file tmpfile_stdout 01:09:48 INFO - Output received: 01:09:48 INFO - /builds/slave/test/build/application/firefox/firefox 01:09:48 INFO - Running post-action listener: _resource_record_post_action 01:09:48 INFO - [mozharness: 2017-07-28 08:09:48.252722Z] Finished install step (success) 01:09:48 INFO - [mozharness: 2017-07-28 08:09:48.252977Z] Running setup-mitmproxy step. 01:09:48 INFO - Running pre-action listener: _resource_record_pre_action 01:09:48 INFO - Running main action method: setup_mitmproxy 01:09:48 INFO - Skipping: mitmproxy is not required 01:09:48 INFO - Running post-action listener: _resource_record_post_action 01:09:48 INFO - [mozharness: 2017-07-28 08:09:48.254118Z] Finished setup-mitmproxy step (success) 01:09:48 INFO - [mozharness: 2017-07-28 08:09:48.254340Z] Running run-tests step. 01:09:48 INFO - Running pre-action listener: _resource_record_pre_action 01:09:48 INFO - Running pre-action listener: _set_gcov_prefix 01:09:48 INFO - Running main action method: run_tests 01:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:09:48 INFO - Python 2.7.3 01:09:48 INFO - Return code: 0 01:09:48 INFO - grabbing minidump binary from tooltool 01:09: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')]} 01:09:48 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 0x1b93eb0>, '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 0x1b94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b95240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:09:48 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 01:09:48 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 01:09:48 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 01:09:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:09:48 INFO - Return code: 0 01:09:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:09:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:09:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:09:48 INFO - ENV: RUST_BACKTRACE is now 1 01:09:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:09:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:09:48 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 01:09:48 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 01:09:48 INFO - Using env: {'DISPLAY': ':0', 01:09:48 INFO - 'HOME': '/home/cltbld', 01:09:48 INFO - 'LANG': 'en_US.UTF-8', 01:09:48 INFO - 'LANGUAGE': 'en_US:en', 01:09:48 INFO - 'LOGNAME': 'cltbld', 01:09:48 INFO - 'MAIL': '/var/mail/cltbld', 01:09:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:09:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:48 INFO - 'MOZ_NO_REMOTE': '1', 01:09:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:48 INFO - 'NO_EM_RESTART': '1', 01:09:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:48 INFO - 'PWD': '/builds/slave/test', 01:09:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:09:48 INFO - 'RUST_BACKTRACE': '1', 01:09:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:09:48 INFO - 'SHELL': '/bin/bash', 01:09:48 INFO - 'SHLVL': '1', 01:09:48 INFO - 'STYLO_FORCE_ENABLED': '1', 01:09:48 INFO - 'TERM': 'linux', 01:09:48 INFO - 'TMOUT': '86400', 01:09:48 INFO - 'USER': 'cltbld', 01:09:48 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400', 01:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:48 INFO - '_': '/tools/buildbot/bin/python'} 01:09:48 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 01:09:48 INFO - mozversion application_buildid: 20170728072256 01:09:48 INFO - mozversion application_changeset: 5845151f1a2cd00957fdd48e204542ccbdfaba1e 01:09:48 INFO - mozversion application_display_name: Nightly 01:09:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:09:48 INFO - mozversion application_name: Firefox 01:09:48 INFO - mozversion application_remotingname: firefox 01:09:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:09:48 INFO - mozversion application_vendor: Mozilla 01:09:48 INFO - mozversion application_version: 56.0a1 01:09:48 INFO - mozversion platform_buildid: 20170728072256 01:09:48 INFO - mozversion platform_changeset: 5845151f1a2cd00957fdd48e204542ccbdfaba1e 01:09:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:09:48 INFO - mozversion platform_version: 56.0a1 01:09:48 INFO - using testdate: 1501229388 01:09:48 INFO - actual date: 1501229388 01:09:48 INFO - starting webserver on 'localhost:37590' 01:09:48 INFO - SUITE-START | Running 2 tests 01:09:48 INFO - TEST-START | dromaeo_css 01:09:48 INFO - Initialising browser for dromaeo_css test... 01:09:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37590/getInfo.html -profile /tmp/tmpdxCfSo/profile 01:09:48 INFO - TEST-INFO | started process 3381 (/builds/slave/test/build/application/firefox/firefox http://localhost:37590/getInfo.html) 01:09:57 INFO - TEST-INFO | 3381: exit 0 01:09:57 INFO - Browser initialized. 01:09:57 INFO - Running cycle 1/1 for dromaeo_css test... 01:09:57 INFO - TEST-INFO | started process 3604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdxCfSo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:58 INFO - PID 3604 | 01:09:58 INFO - PID 3604 | (/builds/slave/test/build/application/firefox/firefox:3658): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:09:58 INFO - PID 3604 | 01:10:09 INFO - PID 3604 | RSS: Main: 173174784 01:10:09 INFO - PID 3604 | 01:13:09 INFO - PID 3604 | Cycle 1(1): loaded http://localhost:37590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37590/tests/dromaeo/cssquery-ext.html) 01:13:10 INFO - PID 3604 | RSS: Main: 175394816 01:13:10 INFO - PID 3604 | 01:16:12 INFO - PID 3604 | Cycle 1(1): loaded http://localhost:37590/tests/dromaeo/cssquery-ext.html (next: http://localhost:37590/tests/dromaeo/cssquery-jquery.html) 01:16:13 INFO - PID 3604 | RSS: Main: 172998656 01:16:13 INFO - PID 3604 | 01:19:14 INFO - PID 3604 | Cycle 1(1): loaded http://localhost:37590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37590/tests/dromaeo/cssquery-mootools.html) 01:19:15 INFO - PID 3604 | RSS: Main: 175124480 01:19:15 INFO - PID 3604 | 01:22:17 INFO - PID 3604 | Cycle 1(1): loaded http://localhost:37590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37590/tests/dromaeo/cssquery-prototype.html) 01:22:18 INFO - PID 3604 | RSS: Main: 173432832 01:22:18 INFO - PID 3604 | 01:25:21 INFO - PID 3604 | Cycle 1(1): loaded http://localhost:37590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37590/tests/dromaeo/cssquery-yui.html) 01:25:22 INFO - PID 3604 | RSS: Main: 174899200 01:25:22 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | Cycle 1(1): loaded http://localhost:37590/tests/dromaeo/cssquery-yui.html (next: http://localhost:37590/tests/dromaeo/cssquery-dojo.html) 01:28:24 INFO - PID 3604 | RSS: Main: 177258496 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | __start_tp_report 01:28:24 INFO - PID 3604 | _x_x_mozilla_page_load 01:28:24 INFO - PID 3604 | _x_x_mozilla_page_load_details 01:28:24 INFO - PID 3604 | |i|pagename|runs| 01:28:24 INFO - PID 3604 | |0;dojo.html;3139.1838122088266;3140.387624413239;3141.04198219543;3167.9366412671734;3221.468457704479;6083.422074902888;6214.471769899558;6288.402601752838;6292.653904035276;6364.140840986465;6264.31092579817;6311.053341998691;6312.305646378894;6357.650329231902;6381.170447841774;5626.184203290521;5729.799457019005;5735.426457354262;5821.039528477817;5821.476067153955;5721.742521586539;5723.656580605156;5726.255586773714;5726.3987281335485;5746.051901436279;5713.400092990239;5718.085106382959;5723.284589426322;5749.712514374264;5773.913391299155;5663.122216056518;5727.3699893011735;5734.340550836666;5745.913811292834;5763.452472015194;5605.971970140164;5632.127020311858;5690.032694441955;5692.6299790513895;5731.914021289684;6005.159277701126;6077.179580756586;6100.877982440326;6106.145139680449;6112.327643959161;6655.767048153291;6689.297623749485;6753.425958793459;6759.695813688396;6764.289749576322;6844.589324640538;6862.622555759432;6874.931250687479;6875.415589674883;6903.965480172617;6274.309825919146;6291.842703932438;6351.301356850743;6356.745730170834;6357.268914074848;6833.863322733518;6935.583864968118;6939.861202776017;6951.478639102088;7029.92970070303;6512.73949042033;6598.109255250576;6598.274189839114;6616.636085015274;6623.602583844985;6622.1722284714415;6691.230508491489;6702.430293425016;6705.396514313637;6710.362515561014;6664.700088496029;6708.228553716385;6716.630585317855;6720.495962802809;6721.361470660279;6726.899096513556;6758.831029224309;6762.357576030269;6811.659417029129;6827;5376.489233522809;5405;5450.8909821803345;5463.945360546423;5474;4513.368128461952;4617.307403889444;4628.95371046292;4682.555157260055;4700.341952126705;5816.360200377955;5817.7963771267805;5818.44724751148;5834.445727655866;5910.822675319747;6668.233153187349;6693.163354580677;6699.732010719516;6711.362420570038;6785.287544807823;5676.460736230051;5723.399043100498;5769.711514424262;5844.444777746192;5855.853603659943;5931.762729490858;5946.494547963385;5959.28488581373;5968.522518198533;5970.253718285215;6564.245111812107;6600.2409722882485;6602.7689030883685;6606.471482281406;6629.403353698191;6645.368689974444;6718.865622687421;6747.1228740265415;6810.455163587;6816.795496135124;6396.9040464394;6409.615423074631;6497.935020649733;6524.510661700297;6587.2753997061245;6615.305392933865;6642.136522252076;6643.933560664332;6670.899936500859;6677.532572719863;6625.105610742488;6677.799666010027;6750.8649827004165;6837.931620683729;6853;6495.577787443801;6545.2800191979795;6567.770128045496;6572.474202063919;6578.04618330349;6530.216374034956;6536.281009089092;6537.1174891389055;6541.378569035934;6544.9672751635935;6462.515311351762;6466.676666166767;6471.611703297817;6484.1894763154605;6493.383128602775;6554.967225164034;6560.540762146604;6579.835504112435;6606.306337834458;6710.027046078194;6301.936980630135;6378.266499352634;6395.616263024233;6420.6468644225015;6509.283978762238 01:28:24 INFO - PID 3604 | |1;ext.html;811.9472234304769;839.9790005249868;857.1086070486695;866.6706651472443;1173.9647810565687;31604.367912641734;32278.515822262656;41370.379444308324;41852.581474185325;42007.15985680284;42013.57986420135;42233.155336893244;42310.788446057726;42461.7876910615;42467.57532424675;7756.767296981071;7769.922300776991;7948.880766788474;7956.920430795705;7959.2836644701965;7783.260590243918;7912.762617121495;7920.564368959705;7926.564038977854;7934.841303173933;7877.960610196941;7968.840623187532;7974.880376794353;7987.840243195133;7992.200779922019;7879.1726868678825;7891.684332626688;7901.723439679584;7912.920870791305;7929.444938854253;7761.805954851117;7795.688172473095;7797.7660670179985;7813.804654883616;7818.413618978542;36100.45849312263;36405;36462.45306320407;36747.4487882682;37016.444753328724;3489.389356862539;3539;3543.362194804934;3558.1638314995957;3560.572731272238;30360;30438.54342184869;30459.543106853416;30526.84736576325;30544.54183187254;4775.737334446604;4831.371921650198;4853.344798452199;4879.341288926021;4900.6569540132205;181125;181348;181383;181868;182806.08596957062;47848;47959.5204047962;47981.520184798406;48026.759866200446;48217.27674084821;50246.24630630543;50287.24569131466;50351.24473132906;50375.74812125916;50546.49453505492;14846.183459909593;16168.434104806276;16469.176541172892;16494.505164845075;16498.6700265994;12413.813792793115;13429.597112086652;13507.594772156852;13521.932390338183;13543.525976590772;13958;14067.71864562703;14082.225477598831;14084.788728169086;14241.287935603179;5865.882682346414;5897.144913987448;5923.289205295392;5989.670568118708;6095.2685677718955;963.3593660216018;975.453745902297;994.3188915592842;1003.1072345612411;1011.049613363436;21735;21913.452163696034;22250.332490025325;22299.777002230094;22576.0969561219;1054.4306074719718;1062.219268837404;1104.1222228328497;1125.4147843121532;1127.1602656021153;11634.883651163549;14920.40318387274;15191;15400.22998850053;15522.5343239703;225761;225838;228086;228126;228876;52182.47817521852;52806.471935280926;53090.20364694455;53268.73365633147;53305.733471332394;1411.872931436155;1478.3495262084864;1480.8445113263167;1488.3376897280823;1511.7203317386318;25539;25712.472453064707;25996.22011339663;26045.869770651025;27312;48824.75587622039;49291.50708492869;49534.256986144515;49539.50460495493;49653.50346496489;206320;206359;207220;207324;211066;32510.349793003534;32582.51126233061;32695.18262043468;32780.18049548685;35013.824930875184;44598.55401445944;44816.55183448124;45199.32201016921;45363;46585;30680.846595766878;31679.84160079185;31936.007999000125;32626.83686581552;33077.338453231285;30439.391212176077;31905.202369940936;32326.676733232365;32397.352052958337;32411;34298.31403371968;35762.64237357593;35792.46311305281;35883;36296.09259768527;30788.38423231478;32078.679213207568;32147;32210.83894580512;32290.19274518062;22881.542369152856;23353.065877364716;23420.531589368456;23773;24252.87873560621 01:28:24 INFO - PID 3604 | |2;jquery.html;575.5884542552075;580.5529742098581;585.2158108135098;594.1829983772315;608.2822269721728;21261.57476850464;22296.66555001672;22318.21886233982;22398.216062437798;22491.762953037578;25670.358241043938;25953.09164179254;26017.86991065047;26073.957041718357;26250.606240906352;6310.652914089735;6475.5467117301805;6476.611403315793;6478.708458119372;6482.189726284215;6003.879922401549;6451.774187903425;6561.442277406426;6630.4032637062655;6642.368974947372;6574.3754343337305;6590.110335104748;6592.571482853623;6597.142371491699;6597.769078082268;6572.671366431683;6589.769358072444;6592.80221593353;6595.373439523261;6600.570962887445;6071.392860713893;6080.543959203077;6088.482478989291;6092.9695351523405;6112.388761123852;27635.585466218025;28641.57037644416;28682.282942926384;29295.853520732475;29314.267143321373;1927.807219278061;1965.4398496428591;1966.9114889829991;1971.112999150388;1974.3188599933;17990.460286191435;18769.343072992517;18782.248710051583;18850.71723924142;18870.622587548172;2289.198780426854;2302.5510025545027;2339.4853132310864;2395.245497668229;2398.040783686522;131555.34222328922;133946;133986;134635;135584;14415.207163606103;14478.203698796457;14497.637559061108;14596.197209153599;15142;22568.435789105402;23459;23477.1782987598;23489.17787877416;23601.173958911357;9609.711708648752;9682.951585242028;9795.412275263507;9827;9894.752631184278;8919.554022298858;8927.33045021626;8959.059298773665;9046.185843274137;9054.86417703735;9243.26053915685;9505.334626576212;9518.333716639907;9547.856782148274;9577.808443831085;2778.263760103574;2782.318332008671;2786.414852880918;2800.1459554835565;2849.786266030056;933.3140141995627;944.622151139536;949.8005418861978;959;961.3895176562933;18834.905825470785;19067.332643357415;19449.513762155777;19564.119614617375;22891.542169156524;1008.2488546033252;1009.8889122196553;1019.261035749076;1023.4780262066251;1040.54216144896;10716;10974.615888443866;11054.557817687202;11085.778284434427;11224.943875280735;450249;467882;473051;476498.8525172125;477084;116907;119416.40291798659;121349.39325303317;121427;124082;1285.993570032144;1298.798686203621;1317.947282108705;1322.4313545175476;1326.0717497751612;16738.246778894736;17605.471835844946;17621.559461013065;17977.37079202274;18230.270789168284;56019.439805601425;56690.433095668515;56989.71505142448;57185.142222865856;59157.40842591519;69904;70114.29885701077;70375.64812175906;70420;70826.64586677034;14596.197209153599;14981.40074397012;15083.170425626697;15100;15103.47137850214;22594.661080083482;23808.761912380654;25113.87443062773;25269.494610108064;25279;18191.636167276843;18522.351717689817;19278.32525861588;19336.70994935049;19610.50973725668;16176;16757.664846703243;17078.829211707725;17371.305147793948;17633.559161021076;20002.799972000095;20132.39602811918;20389.49026274355;20401;20469.078891449622;14760.63098422548;14786.778198326818;14904;14943.701125977637;15104.093754374773;18410.447686569423;18779.6244075115;18800.52998675044;19034.52413689669;19132.713009304593 01:28:24 INFO - PID 3604 | |3;mootools.html;1387.4103506009947;1427.850075742047;1438.1443041390373;1440.85591440856;1447.710457908418;12956.352182390878;13377.732445351086;13421.194728316295;13424.328783560808;13427.12723672963;13303.935685145188;13764.31178441079;14182.361793719281;14322;14329.355179016944;2602.4664943686594;2667.413169102804;2669.159214847317;2671.6526851509275;2674.371522692166;2491.950160996779;2580.20013795723;2592.364870606704;2615.4115324052127;2625.8293210941324;2640.6303117563557;2647.9470410591775;2657.2294034729907;2673.064427450396;2684.060578797415;2529.127451029392;2561.987190064038;2595.0009246440163;2595.7274486178962;2596.740325967407;2425;2430.4166999920067;2439.1706819681217;2443.7678420550196;2444.0590372706456;13724.313784310845;13801.723965520734;13847.446102155902;13906.652333691638;13956;7432.256774322578;7675.232476752336;7696.769096927102;7697.34572561333;7703.768886933345;4730.266808644666;4879.512048795127;4973.925391119136;4990.800367985276;5041.495850414965;1791.7312403139504;1815.5551889786955;1837.0447367369027;1847.5750577367146;1862.2178684952353;21443.57112857734;21710.34868953934;21726.23958161457;21736.782632173792;21785;6777.186737591521;6852.177738671292;7119.252478489788;7134.143902731706;7143.749968751069;15501.457448989231;15692.450764223197;15699.450519231772;15699.529014129366;15712.68574628501;7478.326950574475;7551.056117985252;7553.924460755432;7555.16893141754;7556.395488360918;6754.763583274562;6944.965275173592;6954.547954382949;6969.7909062728195;6995.965020174866;5019.974900125549;5070.2141168119;5088.0587091388215;5134.768935397916;5274.446183150791;1368.2748143483968;1378.4830688491816;1431.6277767780452;1517.4688858899297;1530;824.6371596497522;847.4957400346784;850.9361797865184;868.3443999780126;874.510274246424;7038.190608080034;7415.443841711894;7459.291367320096;7517.661705223278;7584.582847943416;894.9865752013725;914.1772404835568;943.2642538819595;966.0677446264389;970.4904924914335;4610.193216187154;4620.3762492063815;4624.676272660881;4696.2955556666775;4746.928796068062;18218.544536386697;18627.90686046561;19176.520586985436;19246.326378576963;19294.32469863548;18279.451616451526;18903.905480472786;18984.43046708601;19015.809841901682;19035.428937131906;10865.456727163768;10996.340219586851;11013.83479247812;11015.449227538751;11033.172512061628;7276.7089316426745;7537.698492060256;7620.771376858703;7687.385009199363;7856.135825059125;15695.372185112468;16123.67752644964;16243.675126497168;16442.260098295843;16611.50165495037;15897;16297.266623001757;16413.67172656564;16438.260278287267;16444.342226310815;10257.230707696803;10557.683269501927;10593.682189534326;10657.733556660834;10658.467076645982;11792.115591330856;11847.940760296144;12041.036717062789;12079.154459188125;12123.939380303042;9413.670521531714;9850.753731156492;9939.453330066915;10218.795624087328;10237.129843963048;10077.949610251902;10130.037646423578;10144.746381340525;10325.845112323172;10337.483125843528;7967.322777563972;8472.49165050099;8480.10958849312;8508.191721786421;8508.957455212685;6171.413715697002;6491.707873145625;6512.316206798408;6516.57642253252;6548.672566371567;6158.753649854135;6338.524610654127;6507.219133703797;6529.183852018497;6876.209235937931 01:28:24 INFO - PID 3604 | |4;prototype.html;491.59197865771415;501.1030255842043;521.7678133230713;527.7704198673578;533.0777754484739;6190.7214175362105;6212.83145595746;6262.686865656716;6293.590916590419;6335.809925702236;5938;6057.363976782441;6103.267607887049;6167.62994220346;6173.135760993465;4931.654784165119;4933.654644174909;4973.900521989558;4994.175960966454;5015.724135172564;4950.9504904950845;4963.354763880709;4990.3762029746285;5037.445880953111;5057.6965382077005;4719.716816990975;4846.927296090544;4885.462599114112;4895;4914.262860570925;4909.288153217799;4941.530554597308;4944.566075838003;4956.900861982758;4965.503449655042;4435.489918659331;4454.910901781978;4469.597736203725;4482.708623939434;4485.932711009337;6062.211912451397;6062.363451837582;6068.120122582201;6082.452579267887;6090.269167699905;5718.685472299022;5719.170720245583;5755.712214389264;5756.971215143939;5764.077747560412;6401.295857455676;6502.674866256715;6509.772157974496;6546.541742078057;6560.179977502812;4777.617790576745;4840.273958906192;4864.270359446112;4872.4640289568115;4887.633427492952;6762.8309292267595;6903.689333980034;6935.479839012094;6953.061336719528;6962.408195303456;4959.355283813081;4961.858772482349;4966.726830024383;5001.074801161797;5047;4996.400431948189;5015.573676237488;5045.924311135336;5082.796688132507;5116.386033675983;5592.888142237214;5687.971560142256;5700.885982280414;5707.3721890592005;5717.685527295956;6512.185976752906;6560.114384558119;6576.342365763481;6627.3372662733345;6638.800835974928;1741.947741567755;1762.3215062201145;1766.938157164493;1767.7967033791022;1776.7956684981134;1144.719543711796;1167.270455965022;1212.6907638552289;1217.379136640302;1230.3848075962019;5652.802151924663;5703.714814259353;5731.799387021518;5764.855878603068;5780.479756821822;6512.511561632802;6591.406773390322;6641.900371494431;6643.302453242437;6671.33286671329;5644.407337229614;5689.943100568941;5695.259616249861;5708.115242137475;5748.511376533042;3517.402041652925;3533.381658209803;3562.7684200526883;3571;3584.211473475831;6376.553641245161;6432.614043157332;6480.189976252968;6523.630037692043;6524.445422139172;6853.383195512428;6882.380585747307;6891.241963384024;6916.412104971033;6945.861082778417;6460.903086453707;6471.7734879279;6491.545591808528;6498.577592456475;6525.1517302750335;6633.010096970793;6636.203655561363;6651.667416629052;6708.664566771739;6720.932790672031;6494.188226471691;6522.543421960418;6583.506237032338;6590.406863382319;6651.268360480247;6460.321666224979;6520.967395162994;6560.409563139149;6568.408843204134;6582.17722784652;4907.705537667752;4938.2839488273285;4976.328195693535;4980.452150263541;4992.750362481789;6712.2952090031795;6716.227633821977;6742;6761.560498567577;6835.521513494008;6524.575902566318;6526.869462610816;6570.408663220333;6608.471322294301;6637.933620663732;6431.228252609717;6507.577007494687;6530.67346632676;6539.901901471577;6547.901781473377;6358.809235722936;6438.645874476949;6468.417842394019;6481.967590162208;6527.552167937024;6245.250569931455;6403.3276505966205;6458.806235812933;6580.341965803382;6625.4037136657935;6190.907136392868;6220.688965551795;6259.874802504016;6333.746650133943;6359.523035772429 01:28:24 INFO - PID 3604 | |5;yui.html;877.622622272423;894.3426581462626;906.3836591118037;909.2725819344531;911.4303560274826;16748.330066797327;17037.914810425948;17107.743383849236;17166.39917602884;17238.741418878697;16585.336586536556;17430.65138697225;18373.356932507366;19456.805431945675;19606.70589941152;1032.215516207682;1051.8842927277992;1052.6368402901026;1052.8104941110596;1054.5834395413806;995.6664517386685;997.5710444508858;997.8104160209537;998;1050.4800123938624;1051.164324362134;1076.5263284154946;1098.4562641492473;1101.1906248907046;1101.4878081692011;1069.4492336446735;1069.8127827630171;1069.8288273876142;1070.5396679427843;1075.5052675769155;736.7495051682454;743.305009815824;744.8622004929106;755.4636208292119;788.1921030943272;17989.820101799076;18061.909690451594;18307.908460457747;18434.354797582022;19182.424527264204;19629.31297404584;19649.607007859762;20014.899925500424;20099.296524621568;20105.798942010686;15368.615784605363;15526.922365388215;15698.215089245607;15749.055056696634;15762.448314309058;3461.6365281645317;3468.531748213984;3472.0625431133453;3482.1990942083207;3483.320752453247;110334.44832775866;110527.4985393039;111918;115607.42196289048;121749.39125304406;15779.28993195309;16224.513264602081;16228.918855405647;16233;16248.106354150636;28645.28386790347;28699.28251793722;28982.27544311409;29395.85302073476;29445;8658.48049117055;8890.955545222361;8891.02198758136;8898.154675305836;8946.060663630355;4021.7989100544855;4047.5547689754103;4152.6055024772595;4159.064210552662;4171.3325867860995;5131.281620573122;5173.198154286091;5192.247124166975;5193.324867767242;5210.53105220532;941.275218082073;991.5587563534302;1009.8687170667913;1038.6987773545738;1045.0176833776227;580.4282781460258;615.3262177915176;615.7567760734485;630.2625927664643;641.3105911145537;10628.46857657114;10692.305000174963;10769.299995500267;10931.617393391192;11596.419414331293;662.6984721951501;666.6266890541312;673.8248055505604;686.2691233835949;704.9506534542635;4955.529224723646;5110.1568241239775;5223.190405487156;5224.451432599599;5405;103386;105002;106245;106672.46663766631;108009.45995269973;83717.58141209255;85301.57349213214;94549.5272523633;94650;97050;74261.6286918562;78174;84075.5796221015;89426.55286723655;90615.54692226628;11237.775244495228;11875.703107422383;12053.457594408448;12310.692232694255;12762.042846786713;35585.64414355823;36401.453978190875;36615;37128.62871371252;37332.440013399275;64609.67695161682;65970.01044984425;66302.66848665726;67245.32754672586;68619.65690171717;17035.744463832805;17180.055096969787;17278.481645550655;17320.91339543294;17406;19045.71431428502;19730.30943916956;19956.3015294464;20174.29389971344;20434.79565204329;17207.655846882742;17322.74015889788;18119.728204076684;18671.346502872333;18736.06319683983;17405.825941740928;18032.729509057113;18039.819601803814;18206.271749130417;18762.624747505248;16654.08402537872;17033;17055.82944170592;17195.484135475956;17458.650826983645;11077;11764.35296058725;12211.572594959134;12521.624351269476;13081.476740930257;13078.738425231251;13321.200727956353;13394.464221431423;13803.79294310566;14252.572422827332 01:28:24 INFO - PID 3604 | __end_tp_report 01:28:24 INFO - PID 3604 | __start_cc_report 01:28:24 INFO - PID 3604 | _x_x_mozilla_cycle_collect,348 01:28:24 INFO - PID 3604 | __end_cc_report 01:28:24 INFO - PID 3604 | __startTimestamp1501230504630__endTimestamp 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | ------- Summary: start ------- 01:28:24 INFO - PID 3604 | Number of tests: 6 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | [#0] dojo.html Cycles:165 Average:6187.53 Median:6466.68 stddev:740.68 (11.5%) stddev-sans-first:703.29 01:28:24 INFO - PID 3604 | Values: 3139.2 3140.4 3141.0 3167.9 3221.5 6083.4 6214.5 6288.4 6292.7 6364.1 6264.3 6311.1 6312.3 6357.7 6381.2 5626.2 5729.8 5735.4 5821.0 5821.5 5721.7 5723.7 5726.3 5726.4 5746.1 5713.4 5718.1 5723.3 5749.7 5773.9 5663.1 5727.4 5734.3 5745.9 5763.5 5606.0 5632.1 5690.0 5692.6 5731.9 6005.2 6077.2 6100.9 6106.1 6112.3 6655.8 6689.3 6753.4 6759.7 6764.3 6844.6 6862.6 6874.9 6875.4 6904.0 6274.3 6291.8 6351.3 6356.7 6357.3 6833.9 6935.6 6939.9 6951.5 7029.9 6512.7 6598.1 6598.3 6616.6 6623.6 6622.2 6691.2 6702.4 6705.4 6710.4 6664.7 6708.2 6716.6 6720.5 6721.4 6726.9 6758.8 6762.4 6811.7 6827.0 5376.5 5405.0 5450.9 5463.9 5474.0 4513.4 4617.3 4629.0 4682.6 4700.3 5816.4 5817.8 5818.4 5834.4 5910.8 6668.2 6693.2 6699.7 6711.4 6785.3 5676.5 5723.4 5769.7 5844.4 5855.9 5931.8 5946.5 5959.3 5968.5 5970.3 6564.2 6600.2 6602.8 6606.5 6629.4 6645.4 6718.9 6747.1 6810.5 6816.8 6396.9 6409.6 6497.9 6524.5 6587.3 6615.3 6642.1 6643.9 6670.9 6677.5 6625.1 6677.8 6750.9 6837.9 6853.0 6495.6 6545.3 6567.8 6572.5 6578.0 6530.2 6536.3 6537.1 6541.4 6545.0 6462.5 6466.7 6471.6 6484.2 6493.4 6555.0 6560.5 6579.8 6606.3 6710.0 6301.9 6378.3 6395.6 6420.6 6509.3 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | [#1] ext.html Cycles:180 Average:37844.18 Median:19251.61 stddev:53455.53 (277.7%) stddev-sans-first:53533.16 01:28:24 INFO - PID 3604 | Values: 811.9 840.0 857.1 866.7 1174.0 31604.4 32278.5 41370.4 41852.6 42007.2 42013.6 42233.2 42310.8 42461.8 42467.6 7756.8 7769.9 7948.9 7956.9 7959.3 7783.3 7912.8 7920.6 7926.6 7934.8 7878.0 7968.8 7974.9 7987.8 7992.2 7879.2 7891.7 7901.7 7912.9 7929.4 7761.8 7795.7 7797.8 7813.8 7818.4 36100.5 36405.0 36462.5 36747.4 37016.4 3489.4 3539.0 3543.4 3558.2 3560.6 30360.0 30438.5 30459.5 30526.8 30544.5 4775.7 4831.4 4853.3 4879.3 4900.7 181125.0 181348.0 181383.0 181868.0 182806.1 47848.0 47959.5 47981.5 48026.8 48217.3 50246.2 50287.2 50351.2 50375.7 50546.5 14846.2 16168.4 16469.2 16494.5 16498.7 12413.8 13429.6 13507.6 13521.9 13543.5 13958.0 14067.7 14082.2 14084.8 14241.3 5865.9 5897.1 5923.3 5989.7 6095.3 963.4 975.5 994.3 1003.1 1011.0 21735.0 21913.5 22250.3 22299.8 22576.1 1054.4 1062.2 1104.1 1125.4 1127.2 11634.9 14920.4 15191.0 15400.2 15522.5 225761.0 225838.0 228086.0 228126.0 228876.0 52182.5 52806.5 53090.2 53268.7 53305.7 1411.9 1478.3 1480.8 1488.3 1511.7 25539.0 25712.5 25996.2 26045.9 27312.0 48824.8 49291.5 49534.3 49539.5 49653.5 206320.0 206359.0 207220.0 207324.0 211066.0 32510.3 32582.5 32695.2 32780.2 35013.8 44598.6 44816.6 45199.3 45363.0 46585.0 30680.8 31679.8 31936.0 32626.8 33077.3 30439.4 31905.2 32326.7 32397.4 32411.0 34298.3 35762.6 35792.5 35883.0 36296.1 30788.4 32078.7 32147.0 32210.8 32290.2 22881.5 23353.1 23420.5 23773.0 24252.9 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | [#2] jquery.html Cycles:180 Average:34274.69 Median:23468.09 stddev:79335.45 (338.1%) stddev-sans-first:79517.66 01:28:24 INFO - PID 3604 | Values: 575.6 580.6 585.2 594.2 608.3 21261.6 22296.7 22318.2 22398.2 22491.8 25670.4 25953.1 26017.9 26074.0 26250.6 6310.7 6475.5 6476.6 6478.7 6482.2 6003.9 6451.8 6561.4 6630.4 6642.4 6574.4 6590.1 6592.6 6597.1 6597.8 6572.7 6589.8 6592.8 6595.4 6600.6 6071.4 6080.5 6088.5 6093.0 6112.4 27635.6 28641.6 28682.3 29295.9 29314.3 1927.8 1965.4 1966.9 1971.1 1974.3 17990.5 18769.3 18782.2 18850.7 18870.6 2289.2 2302.6 2339.5 2395.2 2398.0 131555.3 133946.0 133986.0 134635.0 135584.0 14415.2 14478.2 14497.6 14596.2 15142.0 22568.4 23459.0 23477.2 23489.2 23601.2 9609.7 9683.0 9795.4 9827.0 9894.8 8919.6 8927.3 8959.1 9046.2 9054.9 9243.3 9505.3 9518.3 9547.9 9577.8 2778.3 2782.3 2786.4 2800.1 2849.8 933.3 944.6 949.8 959.0 961.4 18834.9 19067.3 19449.5 19564.1 22891.5 1008.2 1009.9 1019.3 1023.5 1040.5 10716.0 10974.6 11054.6 11085.8 11224.9 450249.0 467882.0 473051.0 476498.9 477084.0 116907.0 119416.4 121349.4 121427.0 124082.0 1286.0 1298.8 1317.9 1322.4 1326.1 16738.2 17605.5 17621.6 17977.4 18230.3 56019.4 56690.4 56989.7 57185.1 59157.4 69904.0 70114.3 70375.6 70420.0 70826.6 14596.2 14981.4 15083.2 15100.0 15103.5 22594.7 23808.8 25113.9 25269.5 25279.0 18191.6 18522.4 19278.3 19336.7 19610.5 16176.0 16757.7 17078.8 17371.3 17633.6 20002.8 20132.4 20389.5 20401.0 20469.1 14760.6 14786.8 14904.0 14943.7 15104.1 18410.4 18779.6 18800.5 19034.5 19132.7 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | [#3] mootools.html Cycles:180 Average:8387.29 Median:2586.28 stddev:5695.88 (220.2%) stddev-sans-first:5687.57 01:28:24 INFO - PID 3604 | Values: 1387.4 1427.9 1438.1 1440.9 1447.7 12956.4 13377.7 13421.2 13424.3 13427.1 13303.9 13764.3 14182.4 14322.0 14329.4 2602.5 2667.4 2669.2 2671.7 2674.4 2492.0 2580.2 2592.4 2615.4 2625.8 2640.6 2647.9 2657.2 2673.1 2684.1 2529.1 2562.0 2595.0 2595.7 2596.7 2425.0 2430.4 2439.2 2443.8 2444.1 13724.3 13801.7 13847.4 13906.7 13956.0 7432.3 7675.2 7696.8 7697.3 7703.8 4730.3 4879.5 4973.9 4990.8 5041.5 1791.7 1815.6 1837.0 1847.6 1862.2 21443.6 21710.3 21726.2 21736.8 21785.0 6777.2 6852.2 7119.3 7134.1 7143.7 15501.5 15692.5 15699.5 15699.5 15712.7 7478.3 7551.1 7553.9 7555.2 7556.4 6754.8 6945.0 6954.5 6969.8 6996.0 5020.0 5070.2 5088.1 5134.8 5274.4 1368.3 1378.5 1431.6 1517.5 1530.0 824.6 847.5 850.9 868.3 874.5 7038.2 7415.4 7459.3 7517.7 7584.6 895.0 914.2 943.3 966.1 970.5 4610.2 4620.4 4624.7 4696.3 4746.9 18218.5 18627.9 19176.5 19246.3 19294.3 18279.5 18903.9 18984.4 19015.8 19035.4 10865.5 10996.3 11013.8 11015.4 11033.2 7276.7 7537.7 7620.8 7687.4 7856.1 15695.4 16123.7 16243.7 16442.3 16611.5 15897.0 16297.3 16413.7 16438.3 16444.3 10257.2 10557.7 10593.7 10657.7 10658.5 11792.1 11847.9 12041.0 12079.2 12123.9 9413.7 9850.8 9939.5 10218.8 10237.1 10077.9 10130.0 10144.7 10325.8 10337.5 7967.3 8472.5 8480.1 8508.2 8509.0 6171.4 6491.7 6512.3 6516.6 6548.7 6158.8 6338.5 6507.2 6529.2 6876.2 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | [#4] prototype.html Cycles:180 Average:5489.89 Median:6086.36 stddev:1542.65 (25.3%) stddev-sans-first:1500.67 01:28:24 INFO - PID 3604 | Values: 491.6 501.1 521.8 527.8 533.1 6190.7 6212.8 6262.7 6293.6 6335.8 5938.0 6057.4 6103.3 6167.6 6173.1 4931.7 4933.7 4973.9 4994.2 5015.7 4951.0 4963.4 4990.4 5037.4 5057.7 4719.7 4846.9 4885.5 4895.0 4914.3 4909.3 4941.5 4944.6 4956.9 4965.5 4435.5 4454.9 4469.6 4482.7 4485.9 6062.2 6062.4 6068.1 6082.5 6090.3 5718.7 5719.2 5755.7 5757.0 5764.1 6401.3 6502.7 6509.8 6546.5 6560.2 4777.6 4840.3 4864.3 4872.5 4887.6 6762.8 6903.7 6935.5 6953.1 6962.4 4959.4 4961.9 4966.7 5001.1 5047.0 4996.4 5015.6 5045.9 5082.8 5116.4 5592.9 5688.0 5700.9 5707.4 5717.7 6512.2 6560.1 6576.3 6627.3 6638.8 1741.9 1762.3 1766.9 1767.8 1776.8 1144.7 1167.3 1212.7 1217.4 1230.4 5652.8 5703.7 5731.8 5764.9 5780.5 6512.5 6591.4 6641.9 6643.3 6671.3 5644.4 5689.9 5695.3 5708.1 5748.5 3517.4 3533.4 3562.8 3571.0 3584.2 6376.6 6432.6 6480.2 6523.6 6524.4 6853.4 6882.4 6891.2 6916.4 6945.9 6460.9 6471.8 6491.5 6498.6 6525.2 6633.0 6636.2 6651.7 6708.7 6720.9 6494.2 6522.5 6583.5 6590.4 6651.3 6460.3 6521.0 6560.4 6568.4 6582.2 4907.7 4938.3 4976.3 4980.5 4992.8 6712.3 6716.2 6742.0 6761.6 6835.5 6524.6 6526.9 6570.4 6608.5 6637.9 6431.2 6507.6 6530.7 6539.9 6547.9 6358.8 6438.6 6468.4 6482.0 6527.6 6245.3 6403.3 6458.8 6580.3 6625.4 6190.9 6220.7 6259.9 6333.7 6359.5 01:28:24 INFO - PID 3604 | 01:28:24 INFO - PID 3604 | [#5] yui.html Cycles:180 Average:22383.28 Median:18904.17 stddev:30073.24 (159.1%) stddev-sans-first:30114.25 01:28:24 INFO - PID 3604 | Values: 877.6 894.3 906.4 909.3 911.4 16748.3 17037.9 17107.7 17166.4 17238.7 16585.3 17430.7 18373.4 19456.8 19606.7 1032.2 1051.9 1052.6 1052.8 1054.6 995.7 997.6 997.8 998.0 1050.5 1051.2 1076.5 1098.5 1101.2 1101.5 1069.4 1069.8 1069.8 1070.5 1075.5 736.7 743.3 744.9 755.5 788.2 17989.8 18061.9 18307.9 18434.4 19182.4 19629.3 19649.6 20014.9 20099.3 20105.8 15368.6 15526.9 15698.2 15749.1 15762.4 3461.6 3468.5 3472.1 3482.2 3483.3 110334.4 110527.5 111918.0 115607.4 121749.4 15779.3 16224.5 16228.9 16233.0 16248.1 28645.3 28699.3 28982.3 29395.9 29445.0 8658.5 8891.0 8891.0 8898.2 8946.1 4021.8 4047.6 4152.6 4159.1 4171.3 5131.3 5173.2 5192.2 5193.3 5210.5 941.3 991.6 1009.9 1038.7 1045.0 580.4 615.3 615.8 630.3 641.3 10628.5 10692.3 10769.3 10931.6 11596.4 662.7 666.6 673.8 686.3 705.0 4955.5 5110.2 5223.2 5224.5 5405.0 103386.0 105002.0 106245.0 106672.5 108009.5 83717.6 85301.6 94549.5 94650.0 97050.0 74261.6 78174.0 84075.6 89426.6 90615.5 11237.8 11875.7 12053.5 12310.7 12762.0 35585.6 36401.5 36615.0 37128.6 37332.4 64609.7 65970.0 66302.7 67245.3 68619.7 17035.7 17180.1 17278.5 17320.9 17406.0 19045.7 19730.3 19956.3 20174.3 20434.8 17207.7 17322.7 18119.7 18671.3 18736.1 17405.8 18032.7 18039.8 18206.3 18762.6 16654.1 17033.0 17055.8 17195.5 17458.7 11077.0 11764.4 12211.6 12521.6 13081.5 13078.7 13321.2 13394.5 13803.8 14252.6 01:28:24 INFO - PID 3604 | -------- Summary: end -------- 01:28:24 INFO - PID 3604 | 01:28:25 INFO - TEST-INFO | 3604: exit 0 01:28:25 INFO - TEST-OK | dromaeo_css | took 1116616ms 01:28:25 INFO - TEST-START | kraken 01:28:25 INFO - Initialising browser for kraken test... 01:28:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37590/getInfo.html -profile /tmp/tmpFRrMvC/profile 01:28:25 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox http://localhost:37590/getInfo.html) 01:28:31 INFO - TEST-INFO | 3973: exit 0 01:28:31 INFO - Browser initialized. 01:28:31 INFO - Running cycle 1/1 for kraken test... 01:28:31 INFO - TEST-INFO | started process 4201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFRrMvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:32 INFO - PID 4201 | 01:28:32 INFO - PID 4201 | (/builds/slave/test/build/application/firefox/firefox:4257): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:28:32 INFO - PID 4201 | 01:28:42 INFO - PID 4201 | RSS: Main: 173707264 01:28:42 INFO - PID 4201 | 01:28:45 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37590/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:46 INFO - PID 4201 | RSS: Main: 178679808 01:28:46 INFO - PID 4201 | 01:28:49 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37590/tests/kraken/driver.html?testName=audio-dft) 01:28:49 INFO - PID 4201 | RSS: Main: 179150848 01:28:49 INFO - PID 4201 | 01:28:53 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37590/tests/kraken/driver.html?testName=audio-fft) 01:28:53 INFO - PID 4201 | RSS: Main: 174239744 01:28:53 INFO - PID 4201 | 01:28:55 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37590/tests/kraken/driver.html?testName=audio-oscillator) 01:28:56 INFO - PID 4201 | RSS: Main: 174333952 01:28:56 INFO - PID 4201 | 01:28:58 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:59 INFO - PID 4201 | RSS: Main: 174596096 01:28:59 INFO - PID 4201 | 01:29:02 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37590/tests/kraken/driver.html?testName=imaging-darkroom) 01:29:03 INFO - PID 4201 | RSS: Main: 177242112 01:29:03 INFO - PID 4201 | 01:29:06 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37590/tests/kraken/driver.html?testName=imaging-desaturate) 01:29:07 INFO - PID 4201 | RSS: Main: 177246208 01:29:07 INFO - PID 4201 | 01:29:10 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37590/tests/kraken/driver.html?testName=json-parse-financial) 01:29:10 INFO - PID 4201 | RSS: Main: 177934336 01:29:10 INFO - PID 4201 | 01:29:12 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:29:13 INFO - PID 4201 | RSS: Main: 178315264 01:29:13 INFO - PID 4201 | 01:29:15 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:29:15 INFO - PID 4201 | RSS: Main: 175669248 01:29:15 INFO - PID 4201 | 01:29:18 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:18 INFO - PID 4201 | RSS: Main: 175222784 01:29:18 INFO - PID 4201 | 01:29:21 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:22 INFO - PID 4201 | RSS: Main: 175685632 01:29:22 INFO - PID 4201 | 01:29:25 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:25 INFO - PID 4201 | RSS: Main: 175591424 01:29:25 INFO - PID 4201 | 01:29:27 INFO - PID 4201 | Cycle 1(1): loaded http://localhost:37590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37590/tests/kraken/driver.html?testName=ai-astar) 01:29:28 INFO - PID 4201 | RSS: Main: 177631232 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | __start_tp_report 01:29:28 INFO - PID 4201 | _x_x_mozilla_page_load 01:29:28 INFO - PID 4201 | _x_x_mozilla_page_load_details 01:29:28 INFO - PID 4201 | |i|pagename|runs| 01:29:28 INFO - PID 4201 | |0;ai-astar;101;111;110;108;111;115;110;99;114;121 01:29:28 INFO - PID 4201 | |1;audio-beat-detection;150;122;149;169;119;145;148;119;167;117 01:29:28 INFO - PID 4201 | |2;audio-dft;166;167;163;162;163;163;162;170;166;164 01:29:28 INFO - PID 4201 | |3;audio-fft;75;76;80;185;76;76;76;85;100;78 01:29:28 INFO - PID 4201 | |4;audio-oscillator;82;83;141;79;83;78;152;79;81;129 01:29:28 INFO - PID 4201 | |5;imaging-gaussian-blur;114;113;115;114;114;114;116;117;115;116 01:29:28 INFO - PID 4201 | |6;imaging-darkroom;150;151;150;151;150;155;159;151;151;150 01:29:28 INFO - PID 4201 | |7;imaging-desaturate;93;94;94;93;97;94;99;99;101;93 01:29:28 INFO - PID 4201 | |8;json-parse-financial;65;60;56;63;59;60;57;58;57;57 01:29:28 INFO - PID 4201 | |9;json-stringify-tinderbox;55;62;58;59;53;59;54;54;53;60 01:29:28 INFO - PID 4201 | |10;stanford-crypto-aes;81;82;92;79;82;80;79;80;88;80 01:29:28 INFO - PID 4201 | |11;stanford-crypto-ccm;129;134;136;125;136;130;125;128;126;173 01:29:28 INFO - PID 4201 | |12;stanford-crypto-pbkdf2;186;178;178;176;178;177;174;176;175;176 01:29:28 INFO - PID 4201 | |13;stanford-crypto-sha256-iterative;73;69;74;77;72;70;72;68;74;71 01:29:28 INFO - PID 4201 | __end_tp_report 01:29:28 INFO - PID 4201 | __start_cc_report 01:29:28 INFO - PID 4201 | _x_x_mozilla_cycle_collect,920 01:29:28 INFO - PID 4201 | __end_cc_report 01:29:28 INFO - PID 4201 | __startTimestamp1501230568004__endTimestamp 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | ------- Summary: start ------- 01:29:28 INFO - PID 4201 | Number of tests: 14 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.50 stddev:6.41 (5.7%) stddev-sans-first:5.92 01:29:28 INFO - PID 4201 | Values: 101.0 111.0 110.0 108.0 111.0 115.0 110.0 99.0 114.0 121.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:148.50 stddev:19.92 (13.4%) stddev-sans-first:20.83 01:29:28 INFO - PID 4201 | Values: 150.0 122.0 149.0 169.0 119.0 145.0 148.0 119.0 167.0 117.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.59 (1.6%) stddev-sans-first:2.70 01:29:28 INFO - PID 4201 | Values: 166.0 167.0 163.0 162.0 163.0 163.0 162.0 170.0 166.0 164.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#3] audio-fft Cycles:10 Average:90.70 Median:76.00 stddev:33.99 (44.7%) stddev-sans-first:35.57 01:29:28 INFO - PID 4201 | Values: 75.0 76.0 80.0 185.0 76.0 76.0 76.0 85.0 100.0 78.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:80.00 stddev:29.51 (36.9%) stddev-sans-first:30.68 01:29:28 INFO - PID 4201 | Values: 82.0 83.0 141.0 79.0 83.0 78.0 152.0 79.0 81.0 129.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.23 (1.1%) stddev-sans-first:1.27 01:29:28 INFO - PID 4201 | Values: 114.0 113.0 115.0 114.0 114.0 114.0 116.0 117.0 115.0 116.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.00 stddev:2.94 (1.9%) stddev-sans-first:3.04 01:29:28 INFO - PID 4201 | Values: 150.0 151.0 150.0 151.0 150.0 155.0 159.0 151.0 151.0 150.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:94.00 stddev:3.02 (3.2%) stddev-sans-first:3.04 01:29:28 INFO - PID 4201 | Values: 93.0 94.0 94.0 93.0 97.0 94.0 99.0 99.0 101.0 93.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:2.90 (4.9%) stddev-sans-first:2.19 01:29:28 INFO - PID 4201 | Values: 65.0 60.0 56.0 63.0 59.0 60.0 57.0 58.0 57.0 57.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:58.50 stddev:3.27 (5.6%) stddev-sans-first:3.41 01:29:28 INFO - PID 4201 | Values: 55.0 62.0 58.0 59.0 53.0 59.0 54.0 54.0 53.0 60.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.50 stddev:4.30 (5.3%) stddev-sans-first:4.53 01:29:28 INFO - PID 4201 | Values: 81.0 82.0 92.0 79.0 82.0 80.0 79.0 80.0 88.0 80.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.00 stddev:14.27 (10.8%) stddev-sans-first:15.01 01:29:28 INFO - PID 4201 | Values: 129.0 134.0 136.0 125.0 136.0 130.0 125.0 128.0 126.0 173.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:177.50 stddev:3.31 (1.9%) stddev-sans-first:1.42 01:29:28 INFO - PID 4201 | Values: 186.0 178.0 178.0 176.0 178.0 177.0 174.0 176.0 175.0 176.0 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.50 stddev:2.67 (3.7%) stddev-sans-first:2.80 01:29:28 INFO - PID 4201 | Values: 73.0 69.0 74.0 77.0 72.0 70.0 72.0 68.0 74.0 71.0 01:29:28 INFO - PID 4201 | -------- Summary: end -------- 01:29:28 INFO - PID 4201 | 01:29:28 INFO - PID 4201 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:29:28 INFO - TEST-INFO | 4201: exit 0 01:29:28 INFO - TEST-OK | kraken | took 63340ms 01:29:28 INFO - SUITE-END | took 1179s 01:29:29 INFO - Completed test suite (00:19:40) 01:29:29 INFO - javascript benchmark 01:29:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8390.27953923507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.1838122088266, 3140.387624413239, 3141.04198219543, 3167.9366412671734, 3221.468457704479, 6083.422074902888, 6214.471769899558, 6288.402601752838, 6292.653904035276, 6364.140840986465, 6264.31092579817, 6311.053341998691, 6312.305646378894, 6357.650329231902, 6381.170447841774, 5626.184203290521, 5729.799457019005, 5735.426457354262, 5821.039528477817, 5821.476067153955, 5721.742521586539, 5723.656580605156, 5726.255586773714, 5726.3987281335485, 5746.051901436279, 5713.400092990239, 5718.085106382959, 5723.284589426322, 5749.712514374264, 5773.913391299155, 5663.122216056518, 5727.3699893011735, 5734.340550836666, 5745.913811292834, 5763.452472015194, 5605.971970140164, 5632.127020311858, 5690.032694441955, 5692.6299790513895, 5731.914021289684, 6005.159277701126, 6077.179580756586, 6100.877982440326, 6106.145139680449, 6112.327643959161, 6655.767048153291, 6689.297623749485, 6753.425958793459, 6759.695813688396, 6764.289749576322, 6844.589324640538, 6862.622555759432, 6874.931250687479, 6875.415589674883, 6903.965480172617, 6274.309825919146, 6291.842703932438, 6351.301356850743, 6356.745730170834, 6357.268914074848, 6833.863322733518, 6935.583864968118, 6939.861202776017, 6951.478639102088, 7029.92970070303, 6512.73949042033, 6598.109255250576, 6598.274189839114, 6616.636085015274, 6623.602583844985, 6622.1722284714415, 6691.230508491489, 6702.430293425016, 6705.396514313637, 6710.362515561014, 6664.700088496029, 6708.228553716385, 6716.630585317855, 6720.495962802809, 6721.361470660279, 6726.899096513556, 6758.831029224309, 6762.357576030269, 6811.659417029129, 6827.0, 5376.489233522809, 5405.0, 5450.8909821803345, 5463.945360546423, 5474.0, 4513.368128461952, 4617.307403889444, 4628.95371046292, 4682.555157260055, 4700.341952126705, 5816.360200377955, 5817.7963771267805, 5818.44724751148, 5834.445727655866, 5910.822675319747, 6668.233153187349, 6693.163354580677, 6699.732010719516, 6711.362420570038, 6785.287544807823, 5676.460736230051, 5723.399043100498, 5769.711514424262, 5844.444777746192, 5855.853603659943, 5931.762729490858, 5946.494547963385, 5959.28488581373, 5968.522518198533, 5970.253718285215, 6564.245111812107, 6600.2409722882485, 6602.7689030883685, 6606.471482281406, 6629.403353698191, 6645.368689974444, 6718.865622687421, 6747.1228740265415, 6810.455163587, 6816.795496135124, 6396.9040464394, 6409.615423074631, 6497.935020649733, 6524.510661700297, 6587.2753997061245, 6615.305392933865, 6642.136522252076, 6643.933560664332, 6670.899936500859, 6677.532572719863, 6625.105610742488, 6677.799666010027, 6750.8649827004165, 6837.931620683729, 6853.0, 6495.577787443801, 6545.2800191979795, 6567.770128045496, 6572.474202063919, 6578.04618330349, 6530.216374034956, 6536.281009089092, 6537.1174891389055, 6541.378569035934, 6544.9672751635935, 6462.515311351762, 6466.676666166767, 6471.611703297817, 6484.1894763154605, 6493.383128602775, 6554.967225164034, 6560.540762146604, 6579.835504112435, 6606.306337834458, 6710.027046078194, 6301.936980630135, 6378.266499352634, 6395.616263024233, 6420.6468644225015, 6509.283978762238], "value": 6131.174665699523, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.9472234304769, 839.9790005249868, 857.1086070486695, 866.6706651472443, 1173.9647810565687, 31604.367912641734, 32278.515822262656, 41370.379444308324, 41852.581474185325, 42007.15985680284, 42013.57986420135, 42233.155336893244, 42310.788446057726, 42461.7876910615, 42467.57532424675, 7756.767296981071, 7769.922300776991, 7948.880766788474, 7956.920430795705, 7959.2836644701965, 7783.260590243918, 7912.762617121495, 7920.564368959705, 7926.564038977854, 7934.841303173933, 7877.960610196941, 7968.840623187532, 7974.880376794353, 7987.840243195133, 7992.200779922019, 7879.1726868678825, 7891.684332626688, 7901.723439679584, 7912.920870791305, 7929.444938854253, 7761.805954851117, 7795.688172473095, 7797.7660670179985, 7813.804654883616, 7818.413618978542, 36100.45849312263, 36405.0, 36462.45306320407, 36747.4487882682, 37016.444753328724, 3489.389356862539, 3539.0, 3543.362194804934, 3558.1638314995957, 3560.572731272238, 30360.0, 30438.54342184869, 30459.543106853416, 30526.84736576325, 30544.54183187254, 4775.737334446604, 4831.371921650198, 4853.344798452199, 4879.341288926021, 4900.6569540132205, 181125.0, 181348.0, 181383.0, 181868.0, 182806.08596957062, 47848.0, 47959.5204047962, 47981.520184798406, 48026.759866200446, 48217.27674084821, 50246.24630630543, 50287.24569131466, 50351.24473132906, 50375.74812125916, 50546.49453505492, 14846.183459909593, 16168.434104806276, 16469.176541172892, 16494.505164845075, 16498.6700265994, 12413.813792793115, 13429.597112086652, 13507.594772156852, 13521.932390338183, 13543.525976590772, 13958.0, 14067.71864562703, 14082.225477598831, 14084.788728169086, 14241.287935603179, 5865.882682346414, 5897.144913987448, 5923.289205295392, 5989.670568118708, 6095.2685677718955, 963.3593660216018, 975.453745902297, 994.3188915592842, 1003.1072345612411, 1011.049613363436, 21735.0, 21913.452163696034, 22250.332490025325, 22299.777002230094, 22576.0969561219, 1054.4306074719718, 1062.219268837404, 1104.1222228328497, 1125.4147843121532, 1127.1602656021153, 11634.883651163549, 14920.40318387274, 15191.0, 15400.22998850053, 15522.5343239703, 225761.0, 225838.0, 228086.0, 228126.0, 228876.0, 52182.47817521852, 52806.471935280926, 53090.20364694455, 53268.73365633147, 53305.733471332394, 1411.872931436155, 1478.3495262084864, 1480.8445113263167, 1488.3376897280823, 1511.7203317386318, 25539.0, 25712.472453064707, 25996.22011339663, 26045.869770651025, 27312.0, 48824.75587622039, 49291.50708492869, 49534.256986144515, 49539.50460495493, 49653.50346496489, 206320.0, 206359.0, 207220.0, 207324.0, 211066.0, 32510.349793003534, 32582.51126233061, 32695.18262043468, 32780.18049548685, 35013.824930875184, 44598.55401445944, 44816.55183448124, 45199.32201016921, 45363.0, 46585.0, 30680.846595766878, 31679.84160079185, 31936.007999000125, 32626.83686581552, 33077.338453231285, 30439.391212176077, 31905.202369940936, 32326.676733232365, 32397.352052958337, 32411.0, 34298.31403371968, 35762.64237357593, 35792.46311305281, 35883.0, 36296.09259768527, 30788.38423231478, 32078.679213207568, 32147.0, 32210.83894580512, 32290.19274518062, 22881.542369152856, 23353.065877364716, 23420.531589368456, 23773.0, 24252.87873560621], "value": 17398.145396053384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.5884542552075, 580.5529742098581, 585.2158108135098, 594.1829983772315, 608.2822269721728, 21261.57476850464, 22296.66555001672, 22318.21886233982, 22398.216062437798, 22491.762953037578, 25670.358241043938, 25953.09164179254, 26017.86991065047, 26073.957041718357, 26250.606240906352, 6310.652914089735, 6475.5467117301805, 6476.611403315793, 6478.708458119372, 6482.189726284215, 6003.879922401549, 6451.774187903425, 6561.442277406426, 6630.4032637062655, 6642.368974947372, 6574.3754343337305, 6590.110335104748, 6592.571482853623, 6597.142371491699, 6597.769078082268, 6572.671366431683, 6589.769358072444, 6592.80221593353, 6595.373439523261, 6600.570962887445, 6071.392860713893, 6080.543959203077, 6088.482478989291, 6092.9695351523405, 6112.388761123852, 27635.585466218025, 28641.57037644416, 28682.282942926384, 29295.853520732475, 29314.267143321373, 1927.807219278061, 1965.4398496428591, 1966.9114889829991, 1971.112999150388, 1974.3188599933, 17990.460286191435, 18769.343072992517, 18782.248710051583, 18850.71723924142, 18870.622587548172, 2289.198780426854, 2302.5510025545027, 2339.4853132310864, 2395.245497668229, 2398.040783686522, 131555.34222328922, 133946.0, 133986.0, 134635.0, 135584.0, 14415.207163606103, 14478.203698796457, 14497.637559061108, 14596.197209153599, 15142.0, 22568.435789105402, 23459.0, 23477.1782987598, 23489.17787877416, 23601.173958911357, 9609.711708648752, 9682.951585242028, 9795.412275263507, 9827.0, 9894.752631184278, 8919.554022298858, 8927.33045021626, 8959.059298773665, 9046.185843274137, 9054.86417703735, 9243.26053915685, 9505.334626576212, 9518.333716639907, 9547.856782148274, 9577.808443831085, 2778.263760103574, 2782.318332008671, 2786.414852880918, 2800.1459554835565, 2849.786266030056, 933.3140141995627, 944.622151139536, 949.8005418861978, 959.0, 961.3895176562933, 18834.905825470785, 19067.332643357415, 19449.513762155777, 19564.119614617375, 22891.542169156524, 1008.2488546033252, 1009.8889122196553, 1019.261035749076, 1023.4780262066251, 1040.54216144896, 10716.0, 10974.615888443866, 11054.557817687202, 11085.778284434427, 11224.943875280735, 450249.0, 467882.0, 473051.0, 476498.8525172125, 477084.0, 116907.0, 119416.40291798659, 121349.39325303317, 121427.0, 124082.0, 1285.993570032144, 1298.798686203621, 1317.947282108705, 1322.4313545175476, 1326.0717497751612, 16738.246778894736, 17605.471835844946, 17621.559461013065, 17977.37079202274, 18230.270789168284, 56019.439805601425, 56690.433095668515, 56989.71505142448, 57185.142222865856, 59157.40842591519, 69904.0, 70114.29885701077, 70375.64812175906, 70420.0, 70826.64586677034, 14596.197209153599, 14981.40074397012, 15083.170425626697, 15100.0, 15103.47137850214, 22594.661080083482, 23808.761912380654, 25113.87443062773, 25269.494610108064, 25279.0, 18191.636167276843, 18522.351717689817, 19278.32525861588, 19336.70994935049, 19610.50973725668, 16176.0, 16757.664846703243, 17078.829211707725, 17371.305147793948, 17633.559161021076, 20002.799972000095, 20132.39602811918, 20389.49026274355, 20401.0, 20469.078891449622, 14760.63098422548, 14786.778198326818, 14904.0, 14943.701125977637, 15104.093754374773, 18410.447686569423, 18779.6244075115, 18800.52998675044, 19034.52413689669, 19132.713009304593], "value": 12013.54423768264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.4103506009947, 1427.850075742047, 1438.1443041390373, 1440.85591440856, 1447.710457908418, 12956.352182390878, 13377.732445351086, 13421.194728316295, 13424.328783560808, 13427.12723672963, 13303.935685145188, 13764.31178441079, 14182.361793719281, 14322.0, 14329.355179016944, 2602.4664943686594, 2667.413169102804, 2669.159214847317, 2671.6526851509275, 2674.371522692166, 2491.950160996779, 2580.20013795723, 2592.364870606704, 2615.4115324052127, 2625.8293210941324, 2640.6303117563557, 2647.9470410591775, 2657.2294034729907, 2673.064427450396, 2684.060578797415, 2529.127451029392, 2561.987190064038, 2595.0009246440163, 2595.7274486178962, 2596.740325967407, 2425.0, 2430.4166999920067, 2439.1706819681217, 2443.7678420550196, 2444.0590372706456, 13724.313784310845, 13801.723965520734, 13847.446102155902, 13906.652333691638, 13956.0, 7432.256774322578, 7675.232476752336, 7696.769096927102, 7697.34572561333, 7703.768886933345, 4730.266808644666, 4879.512048795127, 4973.925391119136, 4990.800367985276, 5041.495850414965, 1791.7312403139504, 1815.5551889786955, 1837.0447367369027, 1847.5750577367146, 1862.2178684952353, 21443.57112857734, 21710.34868953934, 21726.23958161457, 21736.782632173792, 21785.0, 6777.186737591521, 6852.177738671292, 7119.252478489788, 7134.143902731706, 7143.749968751069, 15501.457448989231, 15692.450764223197, 15699.450519231772, 15699.529014129366, 15712.68574628501, 7478.326950574475, 7551.056117985252, 7553.924460755432, 7555.16893141754, 7556.395488360918, 6754.763583274562, 6944.965275173592, 6954.547954382949, 6969.7909062728195, 6995.965020174866, 5019.974900125549, 5070.2141168119, 5088.0587091388215, 5134.768935397916, 5274.446183150791, 1368.2748143483968, 1378.4830688491816, 1431.6277767780452, 1517.4688858899297, 1530.0, 824.6371596497522, 847.4957400346784, 850.9361797865184, 868.3443999780126, 874.510274246424, 7038.190608080034, 7415.443841711894, 7459.291367320096, 7517.661705223278, 7584.582847943416, 894.9865752013725, 914.1772404835568, 943.2642538819595, 966.0677446264389, 970.4904924914335, 4610.193216187154, 4620.3762492063815, 4624.676272660881, 4696.2955556666775, 4746.928796068062, 18218.544536386697, 18627.90686046561, 19176.520586985436, 19246.326378576963, 19294.32469863548, 18279.451616451526, 18903.905480472786, 18984.43046708601, 19015.809841901682, 19035.428937131906, 10865.456727163768, 10996.340219586851, 11013.83479247812, 11015.449227538751, 11033.172512061628, 7276.7089316426745, 7537.698492060256, 7620.771376858703, 7687.385009199363, 7856.135825059125, 15695.372185112468, 16123.67752644964, 16243.675126497168, 16442.260098295843, 16611.50165495037, 15897.0, 16297.266623001757, 16413.67172656564, 16438.260278287267, 16444.342226310815, 10257.230707696803, 10557.683269501927, 10593.682189534326, 10657.733556660834, 10658.467076645982, 11792.115591330856, 11847.940760296144, 12041.036717062789, 12079.154459188125, 12123.939380303042, 9413.670521531714, 9850.753731156492, 9939.453330066915, 10218.795624087328, 10237.129843963048, 10077.949610251902, 10130.037646423578, 10144.746381340525, 10325.845112323172, 10337.483125843528, 7967.322777563972, 8472.49165050099, 8480.10958849312, 8508.191721786421, 8508.957455212685, 6171.413715697002, 6491.707873145625, 6512.316206798408, 6516.57642253252, 6548.672566371567, 6158.753649854135, 6338.524610654127, 6507.219133703797, 6529.183852018497, 6876.209235937931], "value": 6156.458875167093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.59197865771415, 501.1030255842043, 521.7678133230713, 527.7704198673578, 533.0777754484739, 6190.7214175362105, 6212.83145595746, 6262.686865656716, 6293.590916590419, 6335.809925702236, 5938.0, 6057.363976782441, 6103.267607887049, 6167.62994220346, 6173.135760993465, 4931.654784165119, 4933.654644174909, 4973.900521989558, 4994.175960966454, 5015.724135172564, 4950.9504904950845, 4963.354763880709, 4990.3762029746285, 5037.445880953111, 5057.6965382077005, 4719.716816990975, 4846.927296090544, 4885.462599114112, 4895.0, 4914.262860570925, 4909.288153217799, 4941.530554597308, 4944.566075838003, 4956.900861982758, 4965.503449655042, 4435.489918659331, 4454.910901781978, 4469.597736203725, 4482.708623939434, 4485.932711009337, 6062.211912451397, 6062.363451837582, 6068.120122582201, 6082.452579267887, 6090.269167699905, 5718.685472299022, 5719.170720245583, 5755.712214389264, 5756.971215143939, 5764.077747560412, 6401.295857455676, 6502.674866256715, 6509.772157974496, 6546.541742078057, 6560.179977502812, 4777.617790576745, 4840.273958906192, 4864.270359446112, 4872.4640289568115, 4887.633427492952, 6762.8309292267595, 6903.689333980034, 6935.479839012094, 6953.061336719528, 6962.408195303456, 4959.355283813081, 4961.858772482349, 4966.726830024383, 5001.074801161797, 5047.0, 4996.400431948189, 5015.573676237488, 5045.924311135336, 5082.796688132507, 5116.386033675983, 5592.888142237214, 5687.971560142256, 5700.885982280414, 5707.3721890592005, 5717.685527295956, 6512.185976752906, 6560.114384558119, 6576.342365763481, 6627.3372662733345, 6638.800835974928, 1741.947741567755, 1762.3215062201145, 1766.938157164493, 1767.7967033791022, 1776.7956684981134, 1144.719543711796, 1167.270455965022, 1212.6907638552289, 1217.379136640302, 1230.3848075962019, 5652.802151924663, 5703.714814259353, 5731.799387021518, 5764.855878603068, 5780.479756821822, 6512.511561632802, 6591.406773390322, 6641.900371494431, 6643.302453242437, 6671.33286671329, 5644.407337229614, 5689.943100568941, 5695.259616249861, 5708.115242137475, 5748.511376533042, 3517.402041652925, 3533.381658209803, 3562.7684200526883, 3571.0, 3584.211473475831, 6376.553641245161, 6432.614043157332, 6480.189976252968, 6523.630037692043, 6524.445422139172, 6853.383195512428, 6882.380585747307, 6891.241963384024, 6916.412104971033, 6945.861082778417, 6460.903086453707, 6471.7734879279, 6491.545591808528, 6498.577592456475, 6525.1517302750335, 6633.010096970793, 6636.203655561363, 6651.667416629052, 6708.664566771739, 6720.932790672031, 6494.188226471691, 6522.543421960418, 6583.506237032338, 6590.406863382319, 6651.268360480247, 6460.321666224979, 6520.967395162994, 6560.409563139149, 6568.408843204134, 6582.17722784652, 4907.705537667752, 4938.2839488273285, 4976.328195693535, 4980.452150263541, 4992.750362481789, 6712.2952090031795, 6716.227633821977, 6742.0, 6761.560498567577, 6835.521513494008, 6524.575902566318, 6526.869462610816, 6570.408663220333, 6608.471322294301, 6637.933620663732, 6431.228252609717, 6507.577007494687, 6530.67346632676, 6539.901901471577, 6547.901781473377, 6358.809235722936, 6438.645874476949, 6468.417842394019, 6481.967590162208, 6527.552167937024, 6245.250569931455, 6403.3276505966205, 6458.806235812933, 6580.341965803382, 6625.4037136657935, 6190.907136392868, 6220.688965551795, 6259.874802504016, 6333.746650133943, 6359.523035772429], "value": 5035.784181588075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.622622272423, 894.3426581462626, 906.3836591118037, 909.2725819344531, 911.4303560274826, 16748.330066797327, 17037.914810425948, 17107.743383849236, 17166.39917602884, 17238.741418878697, 16585.336586536556, 17430.65138697225, 18373.356932507366, 19456.805431945675, 19606.70589941152, 1032.215516207682, 1051.8842927277992, 1052.6368402901026, 1052.8104941110596, 1054.5834395413806, 995.6664517386685, 997.5710444508858, 997.8104160209537, 998.0, 1050.4800123938624, 1051.164324362134, 1076.5263284154946, 1098.4562641492473, 1101.1906248907046, 1101.4878081692011, 1069.4492336446735, 1069.8127827630171, 1069.8288273876142, 1070.5396679427843, 1075.5052675769155, 736.7495051682454, 743.305009815824, 744.8622004929106, 755.4636208292119, 788.1921030943272, 17989.820101799076, 18061.909690451594, 18307.908460457747, 18434.354797582022, 19182.424527264204, 19629.31297404584, 19649.607007859762, 20014.899925500424, 20099.296524621568, 20105.798942010686, 15368.615784605363, 15526.922365388215, 15698.215089245607, 15749.055056696634, 15762.448314309058, 3461.6365281645317, 3468.531748213984, 3472.0625431133453, 3482.1990942083207, 3483.320752453247, 110334.44832775866, 110527.4985393039, 111918.0, 115607.42196289048, 121749.39125304406, 15779.28993195309, 16224.513264602081, 16228.918855405647, 16233.0, 16248.106354150636, 28645.28386790347, 28699.28251793722, 28982.27544311409, 29395.85302073476, 29445.0, 8658.48049117055, 8890.955545222361, 8891.02198758136, 8898.154675305836, 8946.060663630355, 4021.7989100544855, 4047.5547689754103, 4152.6055024772595, 4159.064210552662, 4171.3325867860995, 5131.281620573122, 5173.198154286091, 5192.247124166975, 5193.324867767242, 5210.53105220532, 941.275218082073, 991.5587563534302, 1009.8687170667913, 1038.6987773545738, 1045.0176833776227, 580.4282781460258, 615.3262177915176, 615.7567760734485, 630.2625927664643, 641.3105911145537, 10628.46857657114, 10692.305000174963, 10769.299995500267, 10931.617393391192, 11596.419414331293, 662.6984721951501, 666.6266890541312, 673.8248055505604, 686.2691233835949, 704.9506534542635, 4955.529224723646, 5110.1568241239775, 5223.190405487156, 5224.451432599599, 5405.0, 103386.0, 105002.0, 106245.0, 106672.46663766631, 108009.45995269973, 83717.58141209255, 85301.57349213214, 94549.5272523633, 94650.0, 97050.0, 74261.6286918562, 78174.0, 84075.5796221015, 89426.55286723655, 90615.54692226628, 11237.775244495228, 11875.703107422383, 12053.457594408448, 12310.692232694255, 12762.042846786713, 35585.64414355823, 36401.453978190875, 36615.0, 37128.62871371252, 37332.440013399275, 64609.67695161682, 65970.01044984425, 66302.66848665726, 67245.32754672586, 68619.65690171717, 17035.744463832805, 17180.055096969787, 17278.481645550655, 17320.91339543294, 17406.0, 19045.71431428502, 19730.30943916956, 19956.3015294464, 20174.29389971344, 20434.79565204329, 17207.655846882742, 17322.74015889788, 18119.728204076684, 18671.346502872333, 18736.06319683983, 17405.825941740928, 18032.729509057113, 18039.819601803814, 18206.271749130417, 18762.624747505248, 16654.08402537872, 17033.0, 17055.82944170592, 17195.484135475956, 17458.650826983645, 11077.0, 11764.35296058725, 12211.572594959134, 12521.624351269476, 13081.476740930257, 13078.738425231251, 13321.200727956353, 13394.464221431423, 13803.79294310566, 14252.572422827332], "value": 8780.41570967127, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 108.0, 111.0, 115.0, 110.0, 99.0, 114.0, 121.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 149.0, 169.0, 119.0, 145.0, 148.0, 119.0, 167.0, 117.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 163.0, 162.0, 163.0, 163.0, 162.0, 170.0, 166.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 80.0, 185.0, 76.0, 76.0, 76.0, 85.0, 100.0, 78.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 141.0, 79.0, 83.0, 78.0, 152.0, 79.0, 81.0, 129.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 116.0, 117.0, 115.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 150.0, 155.0, 159.0, 151.0, 151.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 97.0, 94.0, 99.0, 99.0, 101.0, 93.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 56.0, 63.0, 59.0, 60.0, 57.0, 58.0, 57.0, 57.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 58.0, 59.0, 53.0, 59.0, 54.0, 54.0, 53.0, 60.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 92.0, 79.0, 82.0, 80.0, 79.0, 80.0, 88.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 134.0, 136.0, 125.0, 136.0, 130.0, 125.0, 128.0, 126.0, 173.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 178.0, 178.0, 176.0, 178.0, 177.0, 174.0, 176.0, 175.0, 176.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 74.0, 77.0, 72.0, 70.0, 72.0, 68.0, 74.0, 71.0], "value": 72.0, "unit": "score"}]}]} 01:29:29 INFO - Return code: 0 01:29:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:29:29 INFO - # TBPL SUCCESS # 01:29:29 INFO - Running post-action listener: _package_coverage_data 01:29:29 INFO - Running post-action listener: _resource_record_post_action 01:29:29 INFO - [mozharness: 2017-07-28 08:29:29.288512Z] Finished run-tests step (success) 01:29:29 INFO - Running post-run listener: _resource_record_post_run 01:29:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 5701632; Write bytes: 438136832; Read time: 2752; Write time: 443972 01:29:29 INFO - TinderboxPrint: CPU usage
13.2% 01:29:29 INFO - TinderboxPrint: I/O read bytes / time
5,701,632 / 2,752 01:29:29 INFO - TinderboxPrint: I/O write bytes / time
438,136,832 / 443,972 01:29:29 INFO - TinderboxPrint: CPU idle
8,299.9 (86.8%) 01:29:29 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 01:29:29 INFO - TinderboxPrint: Swap in / out
0 / 0 01:29:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114827264; Read time: 44; Write time: 101644 01:29:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:29:29 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 3465216; Write bytes: 323309568; Read time: 2508; Write time: 342328 01:29:29 INFO - Running post-run listener: _upload_blobber_files 01:29:29 INFO - Blob upload gear active. 01:29:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:29 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 01:29:29 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'] 01:29:29 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 01:29:30 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:31 INFO - (blobuploader) - INFO - Done attempting. 01:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:31 INFO - (blobuploader) - INFO - Done attempting. 01:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:32 INFO - (blobuploader) - INFO - Done attempting. 01:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:39 INFO - (blobuploader) - INFO - Done attempting. 01:29:39 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:39 INFO - Return code: 0 01:29:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ceb81f0a97e6f1a9c09db55f113943a145b8573ec686f4a40b4059f4bdb0f1fdbfd91eabfb3802de6283f8992fbe137ad8386b1581b8aa2c2b2aff86c886dfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f91f5cfb14eb7dc2bf559f5c3b57ce5788fff8e609bd16e708a0396a8ee118c782128323842d22f47a012e4b0bd7580fb3f15e6a72b45934e9bbb00ef9ea38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5465e89bc635b5ac31c331285b1ee8dc01ceb0dfffa13193a5e0873a1592a0bd165f3dfa594c6ed3f674fbbf5076f3ca75da087858a6dd174dc69a058a872cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/745a1325db9c3f99b60651b874c3625c75aac91ae4b77126f36184e11d6c69e11e8161748fd57af9311b30f719d68c9f85dc31e64738f506faa6ce760d32fe8f"} 01:29:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:39 INFO - Contents: 01:29:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ceb81f0a97e6f1a9c09db55f113943a145b8573ec686f4a40b4059f4bdb0f1fdbfd91eabfb3802de6283f8992fbe137ad8386b1581b8aa2c2b2aff86c886dfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f91f5cfb14eb7dc2bf559f5c3b57ce5788fff8e609bd16e708a0396a8ee118c782128323842d22f47a012e4b0bd7580fb3f15e6a72b45934e9bbb00ef9ea38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5465e89bc635b5ac31c331285b1ee8dc01ceb0dfffa13193a5e0873a1592a0bd165f3dfa594c6ed3f674fbbf5076f3ca75da087858a6dd174dc69a058a872cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/745a1325db9c3f99b60651b874c3625c75aac91ae4b77126f36184e11d6c69e11e8161748fd57af9311b30f719d68c9f85dc31e64738f506faa6ce760d32fe8f"} 01:29:39 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:39 INFO - Copying logs to upload dir... 01:29:39 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.804427 ========= master_lag: 0.71 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-28 01:29:39.003760) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:39.011860) ========= 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=781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400 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/2ceb81f0a97e6f1a9c09db55f113943a145b8573ec686f4a40b4059f4bdb0f1fdbfd91eabfb3802de6283f8992fbe137ad8386b1581b8aa2c2b2aff86c886dfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f91f5cfb14eb7dc2bf559f5c3b57ce5788fff8e609bd16e708a0396a8ee118c782128323842d22f47a012e4b0bd7580fb3f15e6a72b45934e9bbb00ef9ea38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5465e89bc635b5ac31c331285b1ee8dc01ceb0dfffa13193a5e0873a1592a0bd165f3dfa594c6ed3f674fbbf5076f3ca75da087858a6dd174dc69a058a872cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/745a1325db9c3f99b60651b874c3625c75aac91ae4b77126f36184e11d6c69e11e8161748fd57af9311b30f719d68c9f85dc31e64738f506faa6ce760d32fe8f"} build_url:https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ceb81f0a97e6f1a9c09db55f113943a145b8573ec686f4a40b4059f4bdb0f1fdbfd91eabfb3802de6283f8992fbe137ad8386b1581b8aa2c2b2aff86c886dfc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80f91f5cfb14eb7dc2bf559f5c3b57ce5788fff8e609bd16e708a0396a8ee118c782128323842d22f47a012e4b0bd7580fb3f15e6a72b45934e9bbb00ef9ea38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5465e89bc635b5ac31c331285b1ee8dc01ceb0dfffa13193a5e0873a1592a0bd165f3dfa594c6ed3f674fbbf5076f3ca75da087858a6dd174dc69a058a872cea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/745a1325db9c3f99b60651b874c3625c75aac91ae4b77126f36184e11d6c69e11e8161748fd57af9311b30f719d68c9f85dc31e64738f506faa6ce760d32fe8f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:39.036749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:39.037081) ========= 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=781b77c4c33858b1f599d705000001c1-1501227332.723991-177853400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:39.121245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 01:29:39.124604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 01:29:39.124899) ========= ========= Total master_lag: 0.87 =========