builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1498653299.04 results: success (0) revision: 6190181ff4093756d3f8df754109ed16d132d215 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.039742) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.040163) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.040429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.059942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.060194) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-28 05:34:59-- 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% 22.4M=0.001s 2017-06-28 05:34:59 (22.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.254758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.255071) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:34:59.304338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-28 05:34:59.307696) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6190181ff4093756d3f8df754109ed16d132d215 --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 6190181ff4093756d3f8df754109ed16d132d215 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-28 05:34:59,526 truncating revision to first 12 chars 2017-06-28 05:34:59,526 Setting DEBUG logging. 2017-06-28 05:34:59,526 attempt 1/10 2017-06-28 05:34:59,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6190181ff409?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-28 05:35:00,778 unpacking tar archive at: mozilla-central-6190181ff409/testing/mozharness/ program finished with exit code 0 elapsedTime=1.565636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-28 05:35:00.884863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-28 05:35:00.885124) ========= script_repo_revision: 6190181ff4093756d3f8df754109ed16d132d215 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-28 05:35:00.885470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-28 05:35:00.888740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-28 05:35:00.898247) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-06-28 05:35:00.898500) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:35:01 INFO - MultiFileLogger online at 20170628 05:35:01 in /builds/slave/test 05:35:01 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 05:35:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:01 INFO - {'append_to_log': False, 05:35:01 INFO - 'base_work_dir': '/builds/slave/test', 05:35:01 INFO - 'blob_upload_branch': 'Firefox', 05:35:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:01 INFO - 'branch': 'Firefox', 05:35:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:01 INFO - 'config_files': ('talos/linux_config.py',), 05:35:01 INFO - 'default_actions': ('clobber', 05:35:01 INFO - 'read-buildbot-config', 05:35:01 INFO - 'download-and-extract', 05:35:01 INFO - 'populate-webroot', 05:35:01 INFO - 'create-virtualenv', 05:35:01 INFO - 'install', 05:35:01 INFO - 'setup-mitmproxy', 05:35:01 INFO - 'run-tests'), 05:35:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:01 INFO - 'download_minidump_stackwalk': True, 05:35:01 INFO - 'download_symbols': 'ondemand', 05:35:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:01 INFO - 'gecko_profile': False, 05:35:01 INFO - 'gecko_profile_interval': 0, 05:35:01 INFO - 'installer_path': 'installer.exe', 05:35:01 INFO - 'log_level': 'info', 05:35:01 INFO - 'log_name': 'talos', 05:35:01 INFO - 'log_to_console': True, 05:35:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:35:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:35:01 INFO - 'opt_config_files': (), 05:35:01 INFO - 'pip_index': False, 05:35:01 INFO - 'suite': 'dromaeojs-e10s', 05:35:01 INFO - 'system_bits': '32', 05:35:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:01 INFO - 'title': 'talos-linux64-ix-008', 05:35:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:01 INFO - 'use_talos_json': True, 05:35:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:01 INFO - 'work_dir': 'build'} 05:35:01 INFO - [mozharness: 2017-06-28 12:35:01.206064Z] Running clobber step. 05:35:01 INFO - Running pre-action listener: _resource_record_pre_action 05:35:01 INFO - Running main action method: clobber 05:35:01 INFO - rmtree: /builds/slave/test/build 05:35:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:02 INFO - Running post-action listener: _resource_record_post_action 05:35:02 INFO - [mozharness: 2017-06-28 12:35:02.724749Z] Finished clobber step (success) 05:35:02 INFO - [mozharness: 2017-06-28 12:35:02.724848Z] Running read-buildbot-config step. 05:35:02 INFO - Running pre-action listener: _resource_record_pre_action 05:35:02 INFO - Running main action method: read_buildbot_config 05:35:02 INFO - Using buildbot properties: 05:35:02 INFO - { 05:35:02 INFO - "project": "", 05:35:02 INFO - "product": "firefox", 05:35:02 INFO - "who": "cbook@mozilla.com", 05:35:02 INFO - "installer_path": "public/build/target.tar.bz2", 05:35:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:35:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:35:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:35:02 INFO - "stage_platform": "linux64-pgo", 05:35:02 INFO - "basedir": "/builds/slave/test", 05:35:02 INFO - "buildnumber": 35, 05:35:02 INFO - "platform": "ubuntu64_hw", 05:35:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:35:02 INFO - "slavebuilddir": "test", 05:35:02 INFO - "taskId": "VC92Ge4bQemDG4wEaa_4mw", 05:35:02 INFO - "branch": "mozilla-central", 05:35:02 INFO - "script_repo_revision": "production", 05:35:02 INFO - "revision": "6190181ff4093756d3f8df754109ed16d132d215", 05:35:02 INFO - "slavename": "talos-linux64-ix-008", 05:35:02 INFO - "repo_path": "mozilla-central" 05:35:02 INFO - } 05:35:02 INFO - Finding installer, test and symbols from parent task. 05:35:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VC92Ge4bQemDG4wEaa_4mw'}, attempt #1 05:35:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VC92Ge4bQemDG4wEaa_4mw'}, attempt #1 05:35:03 INFO - Task dependencies: HM975nGcSU22KjrIpZs36w 05:35:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w'}, attempt #1 05:35:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2 05:35:04 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/test_packages.json 05:35:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.crashreporter-symbols.zip 05:35:04 INFO - Running post-action listener: _resource_record_post_action 05:35:04 INFO - [mozharness: 2017-06-28 12:35:04.094198Z] Finished read-buildbot-config step (success) 05:35:04 INFO - [mozharness: 2017-06-28 12:35:04.094416Z] Running download-and-extract step. 05:35:04 INFO - Running pre-action listener: _resource_record_pre_action 05:35:04 INFO - Running main action method: download_and_extract 05:35:04 INFO - mkdir: /builds/slave/test/build/tests 05:35:04 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')]} 05:35:04 INFO - trying https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.test_packages.json 05:35:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:35:04 INFO - Downloaded 989 bytes. 05:35:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:35:04 INFO - Using the following test package requirements: 05:35:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:35:04 INFO - u'common': [u'target.common.tests.zip'], 05:35:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:35:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:35:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:35:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:35:04 INFO - u'mozbase': [u'target.common.tests.zip'], 05:35:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:35:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:35:04 INFO - u'web-platform': [u'target.common.tests.zip', 05:35:04 INFO - u'target.web-platform.tests.tar.gz'], 05:35:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:35:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:35:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.common.tests.zip 05:35:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:35:04 INFO - Fetch https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.common.tests.zip into memory 05:35:05 INFO - Content-Length response header: 68372497 05:35:05 INFO - Bytes received: 68372497 05:35:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:35:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.common.tests.zip 05:35:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:35:16 INFO - Fetch https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.common.tests.zip into memory 05:35:18 INFO - Content-Length response header: 68372497 05:35:18 INFO - Bytes received: 68372497 05:35:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.talos.tests.zip 05:35:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:35:32 INFO - Fetch https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.talos.tests.zip into memory 05:35:33 INFO - Content-Length response header: 14442527 05:35:33 INFO - Bytes received: 14442527 05:35:33 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')]} 05:35:33 INFO - trying https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2 05:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:35:35 INFO - Downloaded 62709020 bytes. 05:35:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2 05:35:35 INFO - mkdir: /builds/slave/test/properties 05:35:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:35 INFO - Contents: 05:35:35 INFO - build_url:https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2 05:35:35 INFO - Running post-action listener: _resource_record_post_action 05:35:35 INFO - Running post-action listener: set_extra_try_arguments 05:35:35 INFO - [mozharness: 2017-06-28 12:35:35.131108Z] Finished download-and-extract step (success) 05:35:35 INFO - [mozharness: 2017-06-28 12:35:35.131203Z] Running populate-webroot step. 05:35:35 INFO - Running pre-action listener: _resource_record_pre_action 05:35:35 INFO - Running main action method: populate_webroot 05:35:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:35 INFO - '--tppagecycles', 05:35:35 INFO - '7'], 05:35:35 INFO - 'tests': ['tsvgm']}}, 05:35:35 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['damp', 'tps']}, 05:35:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'tests': ['damp', 'tps']}, 05:35:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['dromaeo_dom']}, 05:35:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:35:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:35:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:35:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['a11yr', 05:35:35 INFO - 'ts_paint', 05:35:35 INFO - 'tpaint', 05:35:35 INFO - 'sessionrestore', 05:35:35 INFO - 'sessionrestore_no_auto_restore', 05:35:35 INFO - 'tabpaint']}, 05:35:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:35 INFO - 'ts_paint', 05:35:35 INFO - 'tpaint', 05:35:35 INFO - 'sessionrestore', 05:35:35 INFO - 'sessionrestore_no_auto_restore', 05:35:35 INFO - 'tabpaint']}, 05:35:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:35 INFO - 'ts_paint', 05:35:35 INFO - 'tpaint', 05:35:35 INFO - 'sessionrestore', 05:35:35 INFO - 'sessionrestore_no_auto_restore', 05:35:35 INFO - 'tabpaint']}, 05:35:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:35 INFO - 'ts_paint', 05:35:35 INFO - 'tpaint', 05:35:35 INFO - 'sessionrestore', 05:35:35 INFO - 'sessionrestore_no_auto_restore', 05:35:35 INFO - 'tabpaint']}, 05:35:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['a11yr', 05:35:35 INFO - 'ts_paint', 05:35:35 INFO - 'tpaint', 05:35:35 INFO - 'sessionrestore', 05:35:35 INFO - 'sessionrestore_no_auto_restore', 05:35:35 INFO - 'tabpaint']}, 05:35:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['a11yr', 05:35:35 INFO - 'ts_paint', 05:35:35 INFO - 'tpaint', 05:35:35 INFO - 'sessionrestore', 05:35:35 INFO - 'sessionrestore_no_auto_restore', 05:35:35 INFO - 'tabpaint']}, 05:35:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:35:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:35:35 INFO - 'bloom_basic_ref']}, 05:35:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:35:35 INFO - 'talos_options': ['--mitmproxy', 05:35:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:35:35 INFO - '--firstNonBlankPaint'], 05:35:35 INFO - 'tests': ['quantum_pageload_google', 05:35:35 INFO - 'quantum_pageload_youtube', 05:35:35 INFO - 'quantum_pageload_amazon', 05:35:35 INFO - 'quantum_pageload_facebook']}, 05:35:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['tsvgx', 05:35:35 INFO - 'tsvgr_opacity', 05:35:35 INFO - 'tart', 05:35:35 INFO - 'tscrollx', 05:35:35 INFO - 'cart', 05:35:35 INFO - 'tsvg_static']}, 05:35:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:35 INFO - 'tsvgr_opacity', 05:35:35 INFO - 'tart', 05:35:35 INFO - 'tscrollx', 05:35:35 INFO - 'cart', 05:35:35 INFO - 'tsvg_static']}, 05:35:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'talos_options': ['--disable-e10s'], 05:35:35 INFO - 'tests': ['tp5o']}, 05:35:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:35:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'talos_options': ['--disable-e10s', 05:35:35 INFO - '--xperf_path', 05:35:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:35 INFO - 'tests': ['tp5n']}, 05:35:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:35:35 INFO - 'talos_options': ['--xperf_path', 05:35:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:35 INFO - 'tests': ['tp5n']}}, 05:35:35 INFO - 'talos.zip': {'path': '', 05:35:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:35 INFO - Running post-action listener: _resource_record_post_action 05:35:35 INFO - [mozharness: 2017-06-28 12:35:35.145943Z] Finished populate-webroot step (success) 05:35:35 INFO - [mozharness: 2017-06-28 12:35:35.146032Z] Running create-virtualenv step. 05:35:35 INFO - Running pre-action listener: _resource_record_pre_action 05:35:35 INFO - Running main action method: create_virtualenv 05:35:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:35 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 05:35:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:35:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:35 INFO - Using real prefix '/usr' 05:35:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:37 INFO - Installing pip.................done. 05:35:37 INFO - Return code: 0 05:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:35:37 INFO - Reading from file tmpfile_stdout 05:35:37 INFO - Output received: 05:35:37 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) 05:35:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35: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')]} 05:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:35:37 INFO - Using env: {'DISPLAY': ':0', 05:35:37 INFO - 'HOME': '/home/cltbld', 05:35:37 INFO - 'LANG': 'en_US.UTF-8', 05:35:37 INFO - 'LANGUAGE': 'en_US:en', 05:35:37 INFO - 'LOGNAME': 'cltbld', 05:35:37 INFO - 'MAIL': '/var/mail/cltbld', 05:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:37 INFO - 'MOZ_NO_REMOTE': '1', 05:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:37 INFO - 'NO_EM_RESTART': '1', 05:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:37 INFO - 'PWD': '/builds/slave/test', 05:35:37 INFO - 'SHELL': '/bin/bash', 05:35:37 INFO - 'SHLVL': '1', 05:35:37 INFO - 'TERM': 'linux', 05:35:37 INFO - 'TMOUT': '86400', 05:35:37 INFO - 'USER': 'cltbld', 05:35:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:37 INFO - '_': '/tools/buildbot/bin/python'} 05:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:38 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 05:35:38 INFO - Cleaning up... 05:35:38 INFO - Return code: 0 05:35:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35:38 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')]} 05:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:38 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')]} 05:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:38 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:38 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 05:35:38 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 05:35:38 INFO - Using env: {'DISPLAY': ':0', 05:35:38 INFO - 'HOME': '/home/cltbld', 05:35:38 INFO - 'LANG': 'en_US.UTF-8', 05:35:38 INFO - 'LANGUAGE': 'en_US:en', 05:35:38 INFO - 'LOGNAME': 'cltbld', 05:35:38 INFO - 'MAIL': '/var/mail/cltbld', 05:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:38 INFO - 'MOZ_NO_REMOTE': '1', 05:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:38 INFO - 'NO_EM_RESTART': '1', 05:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:38 INFO - 'PWD': '/builds/slave/test', 05:35:38 INFO - 'SHELL': '/bin/bash', 05:35:38 INFO - 'SHLVL': '1', 05:35:38 INFO - 'TERM': 'linux', 05:35:38 INFO - 'TMOUT': '86400', 05:35:38 INFO - 'USER': 'cltbld', 05:35:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:38 INFO - '_': '/tools/buildbot/bin/python'} 05:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:38 INFO - Downloading/unpacking psutil>=3.1.1 05:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:39 INFO - Installing collected packages: psutil 05:35:39 INFO - Running setup.py install for psutil 05:35:39 INFO - building 'psutil._psutil_linux' extension 05:35:39 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 05:35:39 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 05:35:39 INFO - building 'psutil._psutil_posix' extension 05:35:39 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 05:35:39 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 05:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:40 INFO - Successfully installed psutil 05:35:40 INFO - Cleaning up... 05:35:40 INFO - Return code: 0 05:35:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:35:40 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')]} 05:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:40 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')]} 05:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:40 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:40 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 05:35:40 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 05:35:40 INFO - Using env: {'DISPLAY': ':0', 05:35:40 INFO - 'HOME': '/home/cltbld', 05:35:40 INFO - 'LANG': 'en_US.UTF-8', 05:35:40 INFO - 'LANGUAGE': 'en_US:en', 05:35:40 INFO - 'LOGNAME': 'cltbld', 05:35:40 INFO - 'MAIL': '/var/mail/cltbld', 05:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:40 INFO - 'MOZ_NO_REMOTE': '1', 05:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:40 INFO - 'NO_EM_RESTART': '1', 05:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:40 INFO - 'PWD': '/builds/slave/test', 05:35:40 INFO - 'SHELL': '/bin/bash', 05:35:40 INFO - 'SHLVL': '1', 05:35:40 INFO - 'TERM': 'linux', 05:35:40 INFO - 'TMOUT': '86400', 05:35:40 INFO - 'USER': 'cltbld', 05:35:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:40 INFO - '_': '/tools/buildbot/bin/python'} 05:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:35:40 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 05:35:40 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 05:35:40 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 05:35:40 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 05:35:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:41 INFO - Installing collected packages: mozsystemmonitor 05:35:41 INFO - Running setup.py install for mozsystemmonitor 05:35:41 INFO - Successfully installed mozsystemmonitor 05:35:41 INFO - Cleaning up... 05:35:41 INFO - Return code: 0 05:35:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35:41 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')]} 05:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:41 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')]} 05:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:41 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:41 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 05:35:41 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 05:35:41 INFO - Using env: {'DISPLAY': ':0', 05:35:41 INFO - 'HOME': '/home/cltbld', 05:35:41 INFO - 'LANG': 'en_US.UTF-8', 05:35:41 INFO - 'LANGUAGE': 'en_US:en', 05:35:41 INFO - 'LOGNAME': 'cltbld', 05:35:41 INFO - 'MAIL': '/var/mail/cltbld', 05:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:41 INFO - 'MOZ_NO_REMOTE': '1', 05:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:41 INFO - 'NO_EM_RESTART': '1', 05:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:41 INFO - 'PWD': '/builds/slave/test', 05:35:41 INFO - 'SHELL': '/bin/bash', 05:35:41 INFO - 'SHLVL': '1', 05:35:41 INFO - 'TERM': 'linux', 05:35:41 INFO - 'TMOUT': '86400', 05:35:41 INFO - 'USER': 'cltbld', 05:35:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:41 INFO - '_': '/tools/buildbot/bin/python'} 05:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:41 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 05:35:41 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 05:35:41 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 05:35:41 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 05:35:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35:42 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 05:35:42 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 05:35:42 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 05:35:42 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 05:35:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:43 INFO - warning: no files found matching '*.txt' 05:35:43 INFO - no previously-included directories found matching 'build' 05:35:43 INFO - no previously-included directories found matching 'dist' 05:35:43 INFO - no previously-included directories found matching '.git*' 05:35:43 INFO - Installing collected packages: jsonschema, functools32 05:35:43 INFO - Running setup.py install for functools32 05:35:43 INFO - warning: no files found matching '*.txt' 05:35:43 INFO - no previously-included directories found matching 'build' 05:35:43 INFO - no previously-included directories found matching 'dist' 05:35:43 INFO - no previously-included directories found matching '.git*' 05:35:43 INFO - Successfully installed jsonschema functools32 05:35:43 INFO - Cleaning up... 05:35:43 INFO - Return code: 0 05:35:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:35:43 INFO - Using env: {'DISPLAY': ':0', 05:35:43 INFO - 'HOME': '/home/cltbld', 05:35:43 INFO - 'LANG': 'en_US.UTF-8', 05:35:43 INFO - 'LANGUAGE': 'en_US:en', 05:35:43 INFO - 'LOGNAME': 'cltbld', 05:35:43 INFO - 'MAIL': '/var/mail/cltbld', 05:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:43 INFO - 'MOZ_NO_REMOTE': '1', 05:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:43 INFO - 'NO_EM_RESTART': '1', 05:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:43 INFO - 'PWD': '/builds/slave/test', 05:35:43 INFO - 'SHELL': '/bin/bash', 05:35:43 INFO - 'SHLVL': '1', 05:35:43 INFO - 'TERM': 'linux', 05:35:43 INFO - 'TMOUT': '86400', 05:35:43 INFO - 'USER': 'cltbld', 05:35:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:43 INFO - '_': '/tools/buildbot/bin/python'} 05:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:35:43 INFO - Cleaning up... 05:35:43 INFO - Return code: 0 05:35:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:35:43 INFO - Using env: {'DISPLAY': ':0', 05:35:43 INFO - 'HOME': '/home/cltbld', 05:35:43 INFO - 'LANG': 'en_US.UTF-8', 05:35:43 INFO - 'LANGUAGE': 'en_US:en', 05:35:43 INFO - 'LOGNAME': 'cltbld', 05:35:43 INFO - 'MAIL': '/var/mail/cltbld', 05:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:43 INFO - 'MOZ_NO_REMOTE': '1', 05:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:43 INFO - 'NO_EM_RESTART': '1', 05:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:43 INFO - 'PWD': '/builds/slave/test', 05:35:43 INFO - 'SHELL': '/bin/bash', 05:35:43 INFO - 'SHLVL': '1', 05:35:43 INFO - 'TERM': 'linux', 05:35:43 INFO - 'TMOUT': '86400', 05:35:43 INFO - 'USER': 'cltbld', 05:35:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:43 INFO - '_': '/tools/buildbot/bin/python'} 05:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:45 INFO - Downloading docopt-0.6.1.tar.gz 05:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:45 INFO - Running setup.py install for blobuploader 05:35:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:35:45 INFO - Running setup.py install for requests 05:35:45 INFO - Running setup.py install for docopt 05:35:45 INFO - Successfully installed blobuploader requests docopt 05:35:45 INFO - Cleaning up... 05:35:46 INFO - Return code: 0 05:35:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:46 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:46 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 05:35:46 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 05:35:46 INFO - Using env: {'DISPLAY': ':0', 05:35:46 INFO - 'HOME': '/home/cltbld', 05:35:46 INFO - 'LANG': 'en_US.UTF-8', 05:35:46 INFO - 'LANGUAGE': 'en_US:en', 05:35:46 INFO - 'LOGNAME': 'cltbld', 05:35:46 INFO - 'MAIL': '/var/mail/cltbld', 05:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:46 INFO - 'MOZ_NO_REMOTE': '1', 05:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:46 INFO - 'NO_EM_RESTART': '1', 05:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:46 INFO - 'PWD': '/builds/slave/test', 05:35:46 INFO - 'SHELL': '/bin/bash', 05:35:46 INFO - 'SHLVL': '1', 05:35:46 INFO - 'TERM': 'linux', 05:35:46 INFO - 'TMOUT': '86400', 05:35:46 INFO - 'USER': 'cltbld', 05:35:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:46 INFO - '_': '/tools/buildbot/bin/python'} 05:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:46 INFO - Running setup.py (path:/tmp/pip-EtIq6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:46 INFO - Running setup.py (path:/tmp/pip-jwuoNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:46 INFO - Running setup.py (path:/tmp/pip-aSdtKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:46 INFO - Running setup.py (path:/tmp/pip-fnKCi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:46 INFO - Running setup.py (path:/tmp/pip-B1Lzi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:46 INFO - Running setup.py (path:/tmp/pip-A0FoXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:46 INFO - Running setup.py (path:/tmp/pip-SCD2cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:46 INFO - Running setup.py (path:/tmp/pip-D1GZX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:46 INFO - Running setup.py (path:/tmp/pip-PjKkA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:46 INFO - Running setup.py (path:/tmp/pip-DcKejn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:46 INFO - Running setup.py (path:/tmp/pip-1C3zwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:47 INFO - Running setup.py (path:/tmp/pip-HuUkOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:47 INFO - Running setup.py (path:/tmp/pip-Om7NQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:47 INFO - Running setup.py (path:/tmp/pip-I2eWF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:47 INFO - Running setup.py (path:/tmp/pip-_djaSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:47 INFO - Running setup.py (path:/tmp/pip-B935gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:47 INFO - Running setup.py (path:/tmp/pip-exnosv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:47 INFO - Running setup.py install for manifestparser 05:35:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:35:47 INFO - Running setup.py install for mozcrash 05:35:47 INFO - Running setup.py install for mozdebug 05:35:47 INFO - Running setup.py install for mozdevice 05:35:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:35:47 INFO - Running setup.py install for mozfile 05:35:47 INFO - Running setup.py install for mozhttpd 05:35:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for mozinfo 05:35:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for mozInstall 05:35:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for mozleak 05:35:48 INFO - Running setup.py install for mozlog 05:35:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for moznetwork 05:35:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for mozprocess 05:35:48 INFO - Running setup.py install for mozprofile 05:35:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for mozrunner 05:35:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:35:48 INFO - Running setup.py install for mozscreenshot 05:35:49 INFO - Running setup.py install for moztest 05:35:49 INFO - Running setup.py install for mozversion 05:35:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:35:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:49 INFO - Cleaning up... 05:35:49 INFO - Return code: 0 05:35:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:49 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')]} 05:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:49 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')]} 05:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:49 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:49 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 05:35:49 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 05:35:49 INFO - Using env: {'DISPLAY': ':0', 05:35:49 INFO - 'HOME': '/home/cltbld', 05:35:49 INFO - 'LANG': 'en_US.UTF-8', 05:35:49 INFO - 'LANGUAGE': 'en_US:en', 05:35:49 INFO - 'LOGNAME': 'cltbld', 05:35:49 INFO - 'MAIL': '/var/mail/cltbld', 05:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:49 INFO - 'MOZ_NO_REMOTE': '1', 05:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:49 INFO - 'NO_EM_RESTART': '1', 05:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:49 INFO - 'PWD': '/builds/slave/test', 05:35:49 INFO - 'SHELL': '/bin/bash', 05:35:49 INFO - 'SHLVL': '1', 05:35:49 INFO - 'TERM': 'linux', 05:35:49 INFO - 'TMOUT': '86400', 05:35:49 INFO - 'USER': 'cltbld', 05:35:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:49 INFO - '_': '/tools/buildbot/bin/python'} 05:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:49 INFO - Running setup.py (path:/tmp/pip-kJuqvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:49 INFO - Running setup.py (path:/tmp/pip-FvdCRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:49 INFO - Running setup.py (path:/tmp/pip-O0R7oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:49 INFO - Running setup.py (path:/tmp/pip-AxX7eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:49 INFO - Running setup.py (path:/tmp/pip-bx9S44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:49 INFO - Running setup.py (path:/tmp/pip-Viatt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:49 INFO - Running setup.py (path:/tmp/pip-7oROQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:49 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)) 05:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:49 INFO - Running setup.py (path:/tmp/pip-axTOFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:50 INFO - Running setup.py (path:/tmp/pip-fy4uZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:50 INFO - Running setup.py (path:/tmp/pip-bylhra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:50 INFO - Running setup.py (path:/tmp/pip-ZZ20PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:50 INFO - Running setup.py (path:/tmp/pip-AGuD6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:50 INFO - Running setup.py (path:/tmp/pip-ZdgNdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:50 INFO - Running setup.py (path:/tmp/pip-nFsa3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:50 INFO - Running setup.py (path:/tmp/pip-i03ooh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:50 INFO - Running setup.py (path:/tmp/pip-MXGOdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:50 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)) 05:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:50 INFO - Running setup.py (path:/tmp/pip-_4czkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:50 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)) 05:35:50 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)) 05:35:50 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)) 05:35:50 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)) 05:35:50 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)) 05:35:50 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)) 05:35:50 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)) 05:35:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:51 INFO - Downloading blessings-1.6.tar.gz 05:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:35:51 INFO - Installing collected packages: blessings 05:35:51 INFO - Running setup.py install for blessings 05:35:52 INFO - Successfully installed blessings 05:35:52 INFO - Cleaning up... 05:35:52 INFO - Return code: 0 05:35:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:52 INFO - Reading from file tmpfile_stdout 05:35:52 INFO - Current package versions: 05:35:52 INFO - argparse == 1.2.1 05:35:52 INFO - blessings == 1.6 05:35:52 INFO - blobuploader == 1.2.4 05:35:52 INFO - docopt == 0.6.1 05:35:52 INFO - functools32 == 3.2.3-2 05:35:52 INFO - jsonschema == 2.5.1 05:35:52 INFO - manifestparser == 1.1 05:35:52 INFO - mozInstall == 1.13 05:35:52 INFO - mozcrash == 1.0 05:35:52 INFO - mozdebug == 0.1 05:35:52 INFO - mozdevice == 0.51 05:35:52 INFO - mozfile == 1.2 05:35:52 INFO - mozhttpd == 0.7 05:35:52 INFO - mozinfo == 0.10 05:35:52 INFO - mozleak == 0.1 05:35:52 INFO - mozlog == 3.4 05:35:52 INFO - moznetwork == 0.27 05:35:52 INFO - mozprocess == 0.25 05:35:52 INFO - mozprofile == 0.28 05:35:52 INFO - mozrunner == 6.13 05:35:52 INFO - mozscreenshot == 0.1 05:35:52 INFO - mozsystemmonitor == 0.3 05:35:52 INFO - moztest == 0.8 05:35:52 INFO - mozversion == 1.4 05:35:52 INFO - psutil == 3.1.1 05:35:52 INFO - requests == 1.2.3 05:35:52 INFO - wsgiref == 0.1.2 05:35:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:52 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')]} 05:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:52 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')]} 05:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:52 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:52 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 05:35:52 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 05:35:52 INFO - Using env: {'DISPLAY': ':0', 05:35:52 INFO - 'HOME': '/home/cltbld', 05:35:52 INFO - 'LANG': 'en_US.UTF-8', 05:35:52 INFO - 'LANGUAGE': 'en_US:en', 05:35:52 INFO - 'LOGNAME': 'cltbld', 05:35:52 INFO - 'MAIL': '/var/mail/cltbld', 05:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:52 INFO - 'MOZ_NO_REMOTE': '1', 05:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:52 INFO - 'NO_EM_RESTART': '1', 05:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:52 INFO - 'PWD': '/builds/slave/test', 05:35:52 INFO - 'SHELL': '/bin/bash', 05:35:52 INFO - 'SHLVL': '1', 05:35:52 INFO - 'TERM': 'linux', 05:35:52 INFO - 'TMOUT': '86400', 05:35:52 INFO - 'USER': 'cltbld', 05:35:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:52 INFO - '_': '/tools/buildbot/bin/python'} 05:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 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)) 05:35:52 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:35:52 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 05:35:52 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 05:35:52 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 05:35:52 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 05:35:54 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:35:54 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)) 05:35:54 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)) 05:35:54 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)) 05:35:54 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)) 05:35:54 INFO - Installing collected packages: marionette-driver 05:35:54 INFO - Running setup.py install for marionette-driver 05:35:54 INFO - Successfully installed marionette-driver 05:35:54 INFO - Cleaning up... 05:35:54 INFO - Return code: 0 05:35:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:54 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 0x10c03b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', '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 05:35:54 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 05:35:54 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 05:35:54 INFO - Using env: {'DISPLAY': ':0', 05:35:54 INFO - 'HOME': '/home/cltbld', 05:35:54 INFO - 'LANG': 'en_US.UTF-8', 05:35:54 INFO - 'LANGUAGE': 'en_US:en', 05:35:54 INFO - 'LOGNAME': 'cltbld', 05:35:54 INFO - 'MAIL': '/var/mail/cltbld', 05:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:54 INFO - 'MOZ_NO_REMOTE': '1', 05:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:54 INFO - 'NO_EM_RESTART': '1', 05:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:54 INFO - 'PWD': '/builds/slave/test', 05:35:54 INFO - 'SHELL': '/bin/bash', 05:35:54 INFO - 'SHLVL': '1', 05:35:54 INFO - 'TERM': 'linux', 05:35:54 INFO - 'TMOUT': '86400', 05:35:54 INFO - 'USER': 'cltbld', 05:35:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:54 INFO - '_': '/tools/buildbot/bin/python'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:35:55 INFO - Cleaning up... 05:35:55 INFO - Return code: 0 05:35:55 INFO - Running post-action listener: _resource_record_post_action 05:35:55 INFO - Running post-action listener: _start_resource_monitoring 05:35:55 INFO - Starting resource monitoring. 05:35:55 INFO - [mozharness: 2017-06-28 12:35:55.109811Z] Finished create-virtualenv step (success) 05:35:55 INFO - [mozharness: 2017-06-28 12:35:55.110267Z] Running install step. 05:35:55 INFO - Running pre-action listener: _resource_record_pre_action 05:35:55 INFO - Running main action method: install 05:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:55 INFO - Reading from file tmpfile_stdout 05:35:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:55 INFO - Reading from file tmpfile_stdout 05:35:55 INFO - Output received: 05:35:55 INFO - Usage: mozinstall [options] installer 05:35:55 INFO - Options: 05:35:55 INFO - -h, --help show this help message and exit 05:35:55 INFO - -d DEST, --destination=DEST 05:35:55 INFO - Directory to install application into. [default: 05:35:55 INFO - "/builds/slave/test"] 05:35:55 INFO - --app=APP Application being installed. [default: firefox] 05:35:55 INFO - mkdir: /builds/slave/test/build/application 05:35:55 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'] 05:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:36:14 INFO - Reading from file tmpfile_stdout 05:36:14 INFO - Output received: 05:36:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:36:14 INFO - Running post-action listener: _resource_record_post_action 05:36:14 INFO - [mozharness: 2017-06-28 12:36:14.026474Z] Finished install step (success) 05:36:14 INFO - [mozharness: 2017-06-28 12:36:14.026749Z] Running setup-mitmproxy step. 05:36:14 INFO - Running pre-action listener: _resource_record_pre_action 05:36:14 INFO - Running main action method: setup_mitmproxy 05:36:14 INFO - Skipping: mitmproxy is not required 05:36:14 INFO - Running post-action listener: _resource_record_post_action 05:36:14 INFO - [mozharness: 2017-06-28 12:36:14.027894Z] Finished setup-mitmproxy step (success) 05:36:14 INFO - [mozharness: 2017-06-28 12:36:14.028129Z] Running run-tests step. 05:36:14 INFO - Running pre-action listener: _resource_record_pre_action 05:36:14 INFO - Running main action method: run_tests 05:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:14 INFO - Python 2.7.3 05:36:14 INFO - Return code: 0 05:36:14 INFO - grabbing minidump binary from tooltool 05:36: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')]} 05:36:14 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 0x143c140>, '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 0x143ca40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143ced0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:14 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 05:36:14 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 05:36:14 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 05:36:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:14 INFO - Return code: 0 05:36:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:36:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:14 INFO - ENV: RUST_BACKTRACE is now 1 05:36:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:36:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:14 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/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:36:14 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/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:36:14 INFO - Using env: {'DISPLAY': ':0', 05:36:14 INFO - 'HOME': '/home/cltbld', 05:36:14 INFO - 'LANG': 'en_US.UTF-8', 05:36:14 INFO - 'LANGUAGE': 'en_US:en', 05:36:14 INFO - 'LOGNAME': 'cltbld', 05:36:14 INFO - 'MAIL': '/var/mail/cltbld', 05:36:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:14 INFO - 'MOZ_NO_REMOTE': '1', 05:36:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:14 INFO - 'NO_EM_RESTART': '1', 05:36:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:14 INFO - 'PWD': '/builds/slave/test', 05:36:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:14 INFO - 'RUST_BACKTRACE': '1', 05:36:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:36:14 INFO - 'SHELL': '/bin/bash', 05:36:14 INFO - 'SHLVL': '1', 05:36:14 INFO - 'TERM': 'linux', 05:36:14 INFO - 'TMOUT': '86400', 05:36:14 INFO - 'USER': 'cltbld', 05:36:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549', 05:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:14 INFO - '_': '/tools/buildbot/bin/python'} 05:36:14 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/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:36:14 INFO - mozversion application_buildid: 20170628112051 05:36:14 INFO - mozversion application_changeset: 6190181ff4093756d3f8df754109ed16d132d215 05:36:14 INFO - mozversion application_display_name: Nightly 05:36:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:14 INFO - mozversion application_name: Firefox 05:36:14 INFO - mozversion application_remotingname: firefox 05:36:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:36:14 INFO - mozversion application_vendor: Mozilla 05:36:14 INFO - mozversion application_version: 56.0a1 05:36:14 INFO - mozversion platform_buildid: 20170628112051 05:36:14 INFO - mozversion platform_changeset: 6190181ff4093756d3f8df754109ed16d132d215 05:36:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:36:14 INFO - mozversion platform_version: 56.0a1 05:36:14 INFO - using testdate: 1498653374 05:36:14 INFO - actual date: 1498653374 05:36:14 INFO - starting webserver on 'localhost:36215' 05:36:14 INFO - SUITE-START | Running 2 tests 05:36:14 INFO - TEST-START | dromaeo_css 05:36:14 INFO - operating with platform_type : linux_ 05:36:14 INFO - Initialising browser for dromaeo_css test... 05:36:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36215/getInfo.html -profile /tmp/tmpwJTlmC/profile 05:36:14 INFO - TEST-INFO | started process 12315 (/builds/slave/test/build/application/firefox/firefox http://localhost:36215/getInfo.html) 05:36:20 INFO - TEST-INFO | 12315: exit 0 05:36:20 INFO - Browser initialized. 05:36:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:20 INFO - TEST-INFO | started process 12521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwJTlmC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:31 INFO - PID 12521 | RSS: Main: 161689600 05:36:31 INFO - PID 12521 | 05:39:34 INFO - PID 12521 | Cycle 1(1): loaded http://localhost:36215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36215/tests/dromaeo/cssquery-ext.html) 05:39:36 INFO - PID 12521 | RSS: Main: 170262528 05:39:36 INFO - PID 12521 | 05:42:37 INFO - PID 12521 | Cycle 1(1): loaded http://localhost:36215/tests/dromaeo/cssquery-ext.html (next: http://localhost:36215/tests/dromaeo/cssquery-jquery.html) 05:42:38 INFO - PID 12521 | RSS: Main: 165675008 05:42:38 INFO - PID 12521 | 05:45:40 INFO - PID 12521 | Cycle 1(1): loaded http://localhost:36215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36215/tests/dromaeo/cssquery-mootools.html) 05:45:40 INFO - PID 12521 | RSS: Main: 170020864 05:45:40 INFO - PID 12521 | 05:48:42 INFO - PID 12521 | Cycle 1(1): loaded http://localhost:36215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36215/tests/dromaeo/cssquery-prototype.html) 05:48:42 INFO - PID 12521 | RSS: Main: 169623552 05:48:42 INFO - PID 12521 | 05:51:45 INFO - PID 12521 | Cycle 1(1): loaded http://localhost:36215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36215/tests/dromaeo/cssquery-yui.html) 05:51:46 INFO - PID 12521 | RSS: Main: 168759296 05:51:46 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | Cycle 1(1): loaded http://localhost:36215/tests/dromaeo/cssquery-yui.html (next: http://localhost:36215/tests/dromaeo/cssquery-dojo.html) 05:54:47 INFO - PID 12521 | RSS: Main: 171810816 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | __start_tp_report 05:54:47 INFO - PID 12521 | _x_x_mozilla_page_load 05:54:47 INFO - PID 12521 | _x_x_mozilla_page_load_details 05:54:47 INFO - PID 12521 | |i|pagename|runs| 05:54:47 INFO - PID 12521 | |0;dojo.html;3291.2923721399893;3341.7493687973406;3348.531205631212;3350.798952062876;3374.1395944034284;6105.297890742566;6123.112148738436;6126.969365153179;6134.079888016789;6140.048292514656;6144.047672610742;6162.106494558287;6191.690415479219;6197.752089916398;6207.782727604535;5390.19147127932;5408.161734931092;5410.675359478424;5437.8368648940595;5523.199136125259;5416.566674666037;5465.754041068161;5493.917591236134;5511.807086751965;5519.448055194469;5350.170723537819;5376.11294136467;5438.211459338374;5439.619226654136;5441.347038355383;5368.1679339702405;5401.297831281948;5429.294191755086;5429.348478182604;5433.701146436944;5307.761150748225;5370.516653501204;5380.542653874425;5394.757235924393;5400.432954539795;6058.636481811105;6095.238095238095;6104.908426373608;6110.266767987825;6121.846953826145;6523.5107366947195;6677.966610166966;6688.63212523311;6725.798226053226;6726.562773419712;6685.465162786965;6705.6982435790505;6724.932750672479;6745.662716864186;6746.055552222692;6175.413335733098;6191.504679625664;6220.533459990519;6229.906551401642;6239.032949892774;6770.729170833111;6786.796396108125;6834.453243740588;6858.965705171442;6889.827754306082;6472.935270647327;6505.707243174069;6538.72494863497;6546.869062618816;6548.574342667712;6598.241202261705;6605.70274337656;6640.535162538576;6671.633060181736;6698.095757072831;6665.566738162004;6692;6715.630640314829;6716.664166791738;6721.966390168018;6662.200535935622;6731.32686731323;6755.628440435725;6757.3242675732035;6769.695363708645;5107.33604631403;5118.053160165381;5133.614978876599;5136.5377116059735;5149.613778966593;4418.403515525363;4436.511983681792;4439.66702497314;4477.574630410106;4489.0572979674635;6161.322254551996;6272.6236425814595;6301.117843501914;6317.084022816758;6319.273283572356;6751.223609284897;6796.218434879953;6803.727850885909;6809.182898052166;6815.42068924147;6318.115463834974;6362.586431881913;6363.459105975951;6371.872562548816;6388.137601423841;5763.337216220105;5809.128630705343;5831.504322132581;5840.182374467578;5863.384344643836;7102.893456598258;7118.145822501229;7145.714171433085;7183.281671832775;7188.353048225685;6724.193096828412;6770.695318710768;6787.694553745192;6824.249332573512;6830.112085428863;7154;7161.176464706417;7170.784876453506;7218.061651985208;7231.63841807897;6645.401913827585;6657.900131497934;6668.399844014062;6676.866462670817;6688.097106890507;6643.701033453603;6695.263521012782;6732.293109223461;6734.3602357775935;6827.04421381017;6532.05285233648;6573.211214654272;6584.209894812653;6615.470762338905;6628.038934354395;6512.34876512345;6535.705893234721;6572.671366431755;6587.47300215972;6597.175353080865;6437.871242575216;6549;6561.1470508833545;6577.473802095917;6587.077809106825;6463.709133089116;6478.4169424752;6572.8356791080605;6605.603663780189;6649.168853893263;6359.904601431075;6387.840303992437;6390.968045159744;6414.262359828679;6435.324290949383 05:54:47 INFO - PID 12521 | |1;ext.html;871.9215270625642;931.1386967055467;957.3920560444118;958.966436174734;986.674397448842;42752.57247427529;43552.564474355284;43849.78075109628;43921.560784392146;44211.55788442115;40128.59871401285;40340.39489407661;40802.183956320856;40858.59141408585;40875;6745.797626071213;6833.214180369271;6849.863002739942;6859.451243900476;6860.5540639858245;6702.966485167567;6721.227058888241;6744.797656070301;6770.289119642441;6777.661116944158;6740.898886516707;6767.864642707143;6793.5584187027935;6825;6834.179898412172;6773.221079575838;6802.115724955774;6814.386705196556;6817.386435220829;6818.045473633695;6313.905291420632;6324.304326524125;6353.459955903753;6366.267879193906;6377.202849643794;35642.28715425677;35808.82095589532;35862.10344741376;35865.64134358649;35902.28195436077;3420.538227339327;3459.705924996378;3496.7552271341015;3583.7670551414335;3589.730770192246;32147.357052858813;32508;32614.347713045845;32640.347193056004;32666;3820.331441997639;3821.14024344523;3851.9037024074623;3854.2869569129803;3891.455196272524;215119;215630;219978;220021;221431;48898.26652600214;53916;54640.726796365765;54808.451915481135;55208;57472;57521.137182942286;57523;57779.71110144423;58124;15979.680406391806;16151.919240403722;16184.838151618333;16234.350625974828;16260.75608865868;13099.738005240033;13153.342332883318;13162.539311124065;13185.53850615224;13230.536931207362;15715.21423928799;15849.890507664584;15897.364105435885;15960.920195398949;16019.199040047952;6014.909776353358;6070.969645151746;6233.379321376384;6249.218847644044;6254.781082662085;1061.5859814672283;1066.7173199102244;1087.2932593814085;1092.251807511857;1101.4767985207122;24667.506649866904;24850.751492485204;24935.37661558439;25296.36759081001;25338.239852804076;1151.642990672894;1158.0966845860241;1167.5971789732528;1172.7478592102568;1179.3985067615579;12994.935025324812;13193;13212.141210821266;13306.600801975956;17070.317187312616;265839;267670;269114;269282;270095;62625.373746261954;62887.371126289065;62915.37084629095;63125.684371577845;63129;1461.8684318411395;1519.1948267418286;1519.5213507745025;1524.4465520253532;1531.4486784757478;28597.99907003245;29447.85276073606;29454.11637650874;29996.70003299939;30012.699873001864;42336;42507.574924251596;42569.78715106405;42585.361219581115;42628;230768;231524;231772;232181;233424;33143.50284745779;33822.154446139044;33864.661353387135;33905;36682;43688;45213;45273.09453810971;45598.860028499555;46063.76968115138;34057.48913766345;34218.48672269868;34395.484067739504;34463.13842153866;34611.653883460844;33162.517935616415;33458.66541334555;34012.65987340194;34173;34578.82710586431;39109.804450977565;39498.60501394949;39504.407433889086;39639.603603963595;39857.2028559433;32008.83995580007;33111.83444082764;33115.17212069621;33219.33561328808;33519.664803351654;24394.634080488453;24601.384965376008;24609.753902461463;25116.874415627804;25392.365190870376 05:54:47 INFO - PID 12521 | |2;jquery.html;558.5782734035803;562.5977426140308;565.1607363065849;570.8572856785804;582.3594046548797;22180.223692170777;23272.41818954527;23297.417564560896;23313;23359.416014599643;22112.115515379406;22376.552468950613;23269.185578504756;23379.298621041355;23550.41123971897;6251.843703907393;6417.711202995876;6418;6433.871322573569;6454.580452270611;6152.200213972177;6166.136740856284;6171.4445699887;6175.197224360827;6191.752329906798;5808.883822323551;6104.847378815543;6156.876862462748;6182.412670796267;6188.443040126388;6173.691315434233;6185.690715464231;6202.565820392551;6214.440700336946;6227.221597300338;5803.303603567557;5809.128630705386;5810.331811841608;5812.941870581282;5819.970900145515;29889.850550747324;30194.245143871358;30208.395832083235;30209.848950755324;30228.8488557558;2203.46015226269;2278.362058623588;2305.9968913522503;2313.8958746856433;2326.1044497868443;19446.51383715404;19491.80508194914;19674.114664839974;19716.408507744647;19738.70391944122;2366.89299814641;2421.479381932893;2457.8648174350405;2463.310273123528;2464.5440593490084;136513;139985;140459;140882;141451.29274353563;15057.54827355181;15190.405007474055;15300.846991529943;15417.383304667912;15643.530694078969;23569.17507887216;23589;23631.881840590686;23635.40911477227;23659.645105323434;9736.805263894683;9747.122758951728;9905.702828915144;9930.751731206634;9942.552585133686;8782.91217087821;8786.60460279289;8897.466152030898;8915.420497667761;8940.776480587907;9481.288903332139;9493;9527.142557169887;9572.856407153899;9675.806483870283;2647.7484638959268;2709.051831858834;2763.1710486854267;2782.791290653209;2787.28924124347;1022.539857064324;1026.7381817636604;1046.5186014433293;1050.485262221506;1054.2725519391595;20639.4840128995;20865;21020.78979210219;21199.78800212009;21309.36071917814;1081.7566047639375;1084.1110289562641;1088.7876864011441;1111.2554588425774;1113.7438389170536;10965.780684386267;11620.76758464826;11622.476988535536;11650.6504804856;11697.941510292394;550269;558127;575286;577418;590232;116601;117755;118589;119252;119495.40252298857;1213.9210951288137;1217.6103646833105;1217.7077501399601;1228.3612521488776;1229.26244253449;17732.202050907483;18405.447836564923;18646.254149834396;18697.813021869606;18760.718589221444;53137.7343113282;53147.20279195892;54251.45748542464;54629.45370546244;54766.72616636891;70082;70724;71179.64410177917;71613.28386716066;72944.27055729587;12764.17032892859;13142.145760525535;13205.537806176737;13279.601611951657;13355.933220333836;19377.128029238436;19388.515287117934;19544.511387214865;19545.21819127219;19745.40763777089;14716.55850324492;16335.67328653444;16506.75239871379;16549.420770272984;16621.75067373966;14043.719125617636;14413.279336033365;14690.55928322152;15074.794016478874;15408.075515469107;15965.760513592537;16518.66962660764;16770.24533896002;16924.23840927186;17048.31806727717;12876.22742635445;13097.345132743516;13130.343482825629;13253.13854599448;13255.072144949761;16314.67370652604;16317.755233671267;16417.67164656724;16443.67112657764;16519.66960660756 05:54:47 INFO - PID 12521 | |3;mootools.html;1399.391264799812;1460.3793387810185;1462.846401127881;1465.8754005909498;1470.6396932751484;14554.490592829254;15131;15261.465848695298;15271.465498707548;15296.69406611867;14503.709925801504;14965.176915269656;15004.849951500482;15031.173285469295;15046.699066018673;2637.340664833787;2677.4912766574384;2690.5291573974573;2697.3121853927223;2700.648915640964;2583.922482325524;2678.8526631035284;2680.463907218564;2681.383281845167;2684.3691732442862;2656.734326567347;2676.9464610707773;2692.838429694215;2694.0840114361113;2699.2981824725616;2601.0896186334726;2608.7391260873856;2610.0864697355964;2615.0193677370985;2619.332070322065;2556.4759224358963;2576.6521519594803;2586.2499875036406;2586.4697736964067;2589.9482010359875;13694.863051369559;13942.790858137136;13954.162750235018;13972.091814032055;13972.371243294076;7963.721269755589;8232.670693172266;8304.335653147733;8307.792305192419;8313.08556058833;4487.932681009787;4607.631389488833;4662.114198302345;4683.601893839028;4707.811687532529;1577.771223172645;1592.5859276588055;1607.9356825726957;1610.7181243282496;1622.7160246956735;20812.791872081387;21566.676499852514;22508.21221257248;22800.885995570083;22918.885405572866;6372.649504277217;6683.699233534503;7349.448791340671;7378.889316660255;7591.164971853092;19518.414447566596;19760.90119549393;19798.604027919362;19837.801621983883;19870.90064549668;8192.877106843402;8460;8474.1102184271;8476.788080297918;8485.40602157843;7387.150477695134;7579.355754760797;7691.576963266962;7694.115176754633;7720;5407.810726624628;5704.600677952587;5713.457221563945;5734.827955161351;5771.365149833515;1725.1546742096282;1753.587906841891;1772.4151030160017;1789.168036862839;1789.6689112514227;919.5080631861922;929.3680297397834;947.3131979314942;951.362587066667;960.2414092866558;7551.207123251979;7587.317141457185;7694.730684426018;7774.844503109906;7784.260495252942;747.9626018699043;758.0940775773008;764.0792844622217;771.3058247577113;781.0549235425199;5113.411957624847;5599.1041433370465;5609.915851262234;5616.241807355955;5647.519960803378;18847.434576962714;19759.60480790405;19878.50303742418;19924.50188745264;20015.899920500597;20934.685979710317;21187.470313241985;21314;21359.14563417477;21437.78562214358;10813.18901082422;11112.777744445228;11153.163512736577;11380.715482112848;11386.601468948713;8304;8370.58147092655;8452.873206902024;8595.355348348774;8955.59699813497;17347.132643367528;17552.473425797245;17842.5539361517;17860.374886878897;18151.183196755912;17478.650426991644;18458.26166953307;18716.719249211546;18781.060946952326;18869.71695424542;12467.625971220878;12531.122821402414;12578.30819304947;12626.873731262569;12659.050571207381;13230.735385292048;13396.531121410704;13611.863881361456;13639.659008524866;13825.79261311061;10385.532651030873;10748.946255268673;10968.945155274172;11303.265287756269;11550;11034.227604067639;11101.11191104726;11236.438178090899;11264.887351126712;11461.140414468782;10178.18574514052;10178.898211018091;10204.183665306906;10237.078662920372;10341.63804266847;7213.242609526134;7319.5242309249725;7476.925230747623;7542.396608271215;7621.085469743666;7629.7329593463965;7642.235776422313;7663.31030207284;7682.615869206629;7787.688492460238 05:54:47 INFO - PID 12521 | |4;prototype.html;495.18047631170424;512.3672264753029;525.6740820691169;529.3066083430706;530.6046994988734;6157.076438534216;6172.537059720522;6177.980633195517;6197.008478643418;6204.844878878031;5854.38528954459;6086.695665216744;6092.329843717188;6100;6121.510279177666;4721.929171062419;4754.096721622889;4773.474917759044;4803.111424386482;4808.783604737778;4752.7861246244;4770.689905156171;4777.355057067286;4812.663113582051;4814.013127308911;4777.90444191116;4786.928196077061;4802.663813533054;4805.231163013918;4807.975960120195;4582.954170458286;4735.455422626407;4738.549837765407;4747.477777444478;4803.615710743132;4297.226499230137;4300.35494675798;4322.854443572456;4325.805338759764;4351.129774045204;5951.880962380771;5967.641941483482;5975.133605627203;5977.671228082454;5991.3109992351;5703.5437165027115;5737.913931291034;5743.741531631086;5747.252857128588;5754.6547207167705;6564.934350656527;6570.244421891496;6583.6708164592055;6587.814193445178;6592.967035164794;4922.360093187898;4932.062908047459;4937.086638971766;4958.851234462972;4965.726885021322;6818.761343352959;6830.521863469559;6862.691178896912;6870.27862074485;6883.793486195422;5091.719955402488;5096.337476128154;5099.617528685363;5107.795688172506;5119.897602047939;5159.638825282194;5166.509181627739;5168.8966220675375;5180.352455943007;5194.68831870089;5740.712964351766;5765;5765.711714414262;5770.913436298459;5785.074388097884;6464;6588.374104460068;6607.306232845578;6615.140031795836;6632.104665870046;1660.5433505785763;1780.2256018631936;1780.6705759434547;1802.8828126171757;1812.1301775148004;1224.5469176404608;1233.8827811357908;1248.1013670157472;1250.612310183846;1251.3232268759723;6096.969515152396;6187.938120618826;6189.226346706661;6240.188775459162;6261.342559031327;6488.383603557654;6619.271880093186;6694;6729.360710732472;6762.966185169141;6246.437820596168;6259.561830671901;6268.341824108403;6292.370762923671;6304.306526282197;3493.1965647901125;3528.6471352865024;3542.4509201073874;3544.858205671744;3553.911152221215;7049.718011279491;7135.250798666066;7136.536125151849;7171.856562868714;7189.928100718926;6833.897491537531;6839.350261725128;6858.039874417485;6878.105846239957;6882.208546017172;7094.219635840053;7153.213146553875;7165.713371465083;7177.246389129171;7192.950009247339;6651.368120028589;6660.200775906922;6689.49828762835;6702.262751097278;6746.4940129489505;6606.966965165144;6637.601743895381;6658.600483970978;6675.599464032173;6690.230623478362;6955.756548520778;7180.5691658500655;7182.35358817688;7213.747518836815;7215.015870635617;5000.14997450427;5041.4454410015605;5053.974730126326;5055.797768089235;5070.898582028412;6745.696443659949;6746.392824645609;6754.547772228994;6755.1556055493065;6760;6438.903416448663;6464.7393758216695;6499.870002599827;6507.28419873823;6519.924212504883;6456.418922297016;6525.738970441319;6550.984597387413;6576.342365763386;6583.9465685490095;6522.119513865568;6529.51028672861;6538.313477085027;6545.803625891231;6555.704993275219;6555.475561955128;6594.307597702172;6595.967020164869;6602.933970660232;6608.306127856698;6349.206349206349;6369.299377068612;6395.7121929514215;6408.61548307103;6422.197225346832 05:54:47 INFO - PID 12521 | |5;yui.html;827.5737994932609;839.4249938791925;870.6082262981656;876.1413814461828;876.6449587916892;17482.825171748278;17721.911390443063;17939.641207175864;18096;18132.81867181328;16690.165491725395;16767.580810479743;17207.311707531684;18622;19951.201951921907;1031.5976769060073;1053.8682664666917;1057.1912486947492;1064.920130990179;1066.0991462214456;1060.363781730959;1060.4750648429037;1063.1654151491043;1064.739138910968;1067.4822710985165;1137.562038615135;1142.8342890280903;1143.5654451308492;1144.914131440141;1145.73075327298;1063.494839951025;1082.9350238985608;1089.9400532970683;1135.5060548661318;1135.6309199510151;775.7711475114854;776.0377132355894;776.0687175389555;777.0985656638329;777.3237283563336;17232.310707571683;17250.30998760048;17265.91367043169;17285.30858765648;17374.913125434417;19064.856108633525;19964.80035199644;20091;20153.294634687714;20270.69593956077;15655.92172039144;16035.518934431986;16039.759403608838;16047.35810567576;16233;3643;3645.179834537208;3649.872254471081;3675.2833197526493;3679.2825399047197;80326.59836700838;110689;112803;116550.83449165485;118311;13668.93165534166;13937.721245575032;16142.75785863213;16617.99999999976;16647.583810404838;28414.431711365658;28523.85738071338;29325.85337073301;29391.26521836971;29577;8251.711190108317;8286.751397458085;8301.8339633207;8347.248747612623;8363.95818020906;4108.794560271975;4141.937870931938;4145.108801607669;4146.295129827937;4150.190712811033;4917.164082105979;4954.083494553519;4976.353074100416;4981.626378021663;5054.494550544916;968.864358989742;991.6727479931606;993.7764003099389;1006.225206590921;1009.5103874620803;702.9437644988388;706.0715159565156;728.6575309604477;730.422965856967;731.0459849895936;12913.612591622266;13026.54407095766;13153.60539183826;13894.93052534751;14884.776728349083;711.3349018667562;722.2019668266595;730.3317464519905;749.57274353619;761.4213197969473;5833.591648584643;5917.822465326047;5958.880822383615;6122.602030867979;6258.812235632939;105854.47072764586;108352;109987;111389;112046.43976780064;91048;94523;95140;95671;97618;79740.20259797444;85537.14462855416;86959;89771;90935;13097.738045239232;13914.09558378702;13915.791263131263;13972.231527266098;14093.577192684235;41320.586794131676;41653.79173104115;42414.36378454264;43976.12047759091;44392;74526.62736686281;75248.62375688087;75674;76690.6165469169;77694;19316.903415482833;19825.504362391057;19872.81399046075;20061.598768024265;20242.392728218176;20031.499212519222;21089.894550527148;21642.6753598693;22325.218617348313;22883.31350059501;20916.37250882476;20989.37031889046;21222.25722099719;21425.357239282846;21557.568848622625;18975.14611842498;19595.510112247306;20451.181952721723;20687.379378618665;21104.894475527522;19807.306744263882;19960;20026.198952042338;20290.69563956512;21025.264115755876;12376.938115309365;12494.687632809253;12548.874511254771;12561.309127998047;12769.680757980754;14096;15184.937054406528;15493.218279897956;15509.146996915279;15894.52316430509 05:54:47 INFO - PID 12521 | __end_tp_report 05:54:47 INFO - PID 12521 | __start_cc_report 05:54:47 INFO - PID 12521 | _x_x_mozilla_cycle_collect,325 05:54:47 INFO - PID 12521 | __end_cc_report 05:54:47 INFO - PID 12521 | __startTimestamp1498654487888__endTimestamp 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | ------- Summary: start ------- 05:54:47 INFO - PID 12521 | Number of tests: 6 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | [#0] dojo.html Cycles:165 Average:6178.10 Median:6472.94 stddev:799.89 (12.4%) stddev-sans-first:769.61 05:54:47 INFO - PID 12521 | Values: 3291.3 3341.7 3348.5 3350.8 3374.1 6105.3 6123.1 6127.0 6134.1 6140.0 6144.0 6162.1 6191.7 6197.8 6207.8 5390.2 5408.2 5410.7 5437.8 5523.2 5416.6 5465.8 5493.9 5511.8 5519.4 5350.2 5376.1 5438.2 5439.6 5441.3 5368.2 5401.3 5429.3 5429.3 5433.7 5307.8 5370.5 5380.5 5394.8 5400.4 6058.6 6095.2 6104.9 6110.3 6121.8 6523.5 6678.0 6688.6 6725.8 6726.6 6685.5 6705.7 6724.9 6745.7 6746.1 6175.4 6191.5 6220.5 6229.9 6239.0 6770.7 6786.8 6834.5 6859.0 6889.8 6472.9 6505.7 6538.7 6546.9 6548.6 6598.2 6605.7 6640.5 6671.6 6698.1 6665.6 6692.0 6715.6 6716.7 6722.0 6662.2 6731.3 6755.6 6757.3 6769.7 5107.3 5118.1 5133.6 5136.5 5149.6 4418.4 4436.5 4439.7 4477.6 4489.1 6161.3 6272.6 6301.1 6317.1 6319.3 6751.2 6796.2 6803.7 6809.2 6815.4 6318.1 6362.6 6363.5 6371.9 6388.1 5763.3 5809.1 5831.5 5840.2 5863.4 7102.9 7118.1 7145.7 7183.3 7188.4 6724.2 6770.7 6787.7 6824.2 6830.1 7154.0 7161.2 7170.8 7218.1 7231.6 6645.4 6657.9 6668.4 6676.9 6688.1 6643.7 6695.3 6732.3 6734.4 6827.0 6532.1 6573.2 6584.2 6615.5 6628.0 6512.3 6535.7 6572.7 6587.5 6597.2 6437.9 6549.0 6561.1 6577.5 6587.1 6463.7 6478.4 6572.8 6605.6 6649.2 6359.9 6387.8 6391.0 6414.3 6435.3 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | [#1] ext.html Cycles:180 Average:41623.59 Median:19054.20 stddev:62653.81 (328.8%) stddev-sans-first:62754.85 05:54:47 INFO - PID 12521 | Values: 871.9 931.1 957.4 959.0 986.7 42752.6 43552.6 43849.8 43921.6 44211.6 40128.6 40340.4 40802.2 40858.6 40875.0 6745.8 6833.2 6849.9 6859.5 6860.6 6703.0 6721.2 6744.8 6770.3 6777.7 6740.9 6767.9 6793.6 6825.0 6834.2 6773.2 6802.1 6814.4 6817.4 6818.0 6313.9 6324.3 6353.5 6366.3 6377.2 35642.3 35808.8 35862.1 35865.6 35902.3 3420.5 3459.7 3496.8 3583.8 3589.7 32147.4 32508.0 32614.3 32640.3 32666.0 3820.3 3821.1 3851.9 3854.3 3891.5 215119.0 215630.0 219978.0 220021.0 221431.0 48898.3 53916.0 54640.7 54808.5 55208.0 57472.0 57521.1 57523.0 57779.7 58124.0 15979.7 16151.9 16184.8 16234.4 16260.8 13099.7 13153.3 13162.5 13185.5 13230.5 15715.2 15849.9 15897.4 15960.9 16019.2 6014.9 6071.0 6233.4 6249.2 6254.8 1061.6 1066.7 1087.3 1092.3 1101.5 24667.5 24850.8 24935.4 25296.4 25338.2 1151.6 1158.1 1167.6 1172.7 1179.4 12994.9 13193.0 13212.1 13306.6 17070.3 265839.0 267670.0 269114.0 269282.0 270095.0 62625.4 62887.4 62915.4 63125.7 63129.0 1461.9 1519.2 1519.5 1524.4 1531.4 28598.0 29447.9 29454.1 29996.7 30012.7 42336.0 42507.6 42569.8 42585.4 42628.0 230768.0 231524.0 231772.0 232181.0 233424.0 33143.5 33822.2 33864.7 33905.0 36682.0 43688.0 45213.0 45273.1 45598.9 46063.8 34057.5 34218.5 34395.5 34463.1 34611.7 33162.5 33458.7 34012.7 34173.0 34578.8 39109.8 39498.6 39504.4 39639.6 39857.2 32008.8 33111.8 33115.2 33219.3 33519.7 24394.6 24601.4 24609.8 25116.9 25392.4 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | [#2] jquery.html Cycles:180 Average:36652.10 Median:2309.95 stddev:95265.69 (4124.2%) stddev-sans-first:95494.39 05:54:47 INFO - PID 12521 | Values: 558.6 562.6 565.2 570.9 582.4 22180.2 23272.4 23297.4 23313.0 23359.4 22112.1 22376.6 23269.2 23379.3 23550.4 6251.8 6417.7 6418.0 6433.9 6454.6 6152.2 6166.1 6171.4 6175.2 6191.8 5808.9 6104.8 6156.9 6182.4 6188.4 6173.7 6185.7 6202.6 6214.4 6227.2 5803.3 5809.1 5810.3 5812.9 5820.0 29889.9 30194.2 30208.4 30209.8 30228.8 2203.5 2278.4 2306.0 2313.9 2326.1 19446.5 19491.8 19674.1 19716.4 19738.7 2366.9 2421.5 2457.9 2463.3 2464.5 136513.0 139985.0 140459.0 140882.0 141451.3 15057.5 15190.4 15300.8 15417.4 15643.5 23569.2 23589.0 23631.9 23635.4 23659.6 9736.8 9747.1 9905.7 9930.8 9942.6 8782.9 8786.6 8897.5 8915.4 8940.8 9481.3 9493.0 9527.1 9572.9 9675.8 2647.7 2709.1 2763.2 2782.8 2787.3 1022.5 1026.7 1046.5 1050.5 1054.3 20639.5 20865.0 21020.8 21199.8 21309.4 1081.8 1084.1 1088.8 1111.3 1113.7 10965.8 11620.8 11622.5 11650.7 11697.9 550269.0 558127.0 575286.0 577418.0 590232.0 116601.0 117755.0 118589.0 119252.0 119495.4 1213.9 1217.6 1217.7 1228.4 1229.3 17732.2 18405.4 18646.3 18697.8 18760.7 53137.7 53147.2 54251.5 54629.5 54766.7 70082.0 70724.0 71179.6 71613.3 72944.3 12764.2 13142.1 13205.5 13279.6 13355.9 19377.1 19388.5 19544.5 19545.2 19745.4 14716.6 16335.7 16506.8 16549.4 16621.8 14043.7 14413.3 14690.6 15074.8 15408.1 15965.8 16518.7 16770.2 16924.2 17048.3 12876.2 13097.3 13130.3 13253.1 13255.1 16314.7 16317.8 16417.7 16443.7 16519.7 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | [#3] mootools.html Cycles:180 Average:9191.18 Median:2566.56 stddev:6292.49 (245.2%) stddev-sans-first:6282.90 05:54:47 INFO - PID 12521 | Values: 1399.4 1460.4 1462.8 1465.9 1470.6 14554.5 15131.0 15261.5 15271.5 15296.7 14503.7 14965.2 15004.8 15031.2 15046.7 2637.3 2677.5 2690.5 2697.3 2700.6 2583.9 2678.9 2680.5 2681.4 2684.4 2656.7 2676.9 2692.8 2694.1 2699.3 2601.1 2608.7 2610.1 2615.0 2619.3 2556.5 2576.7 2586.2 2586.5 2589.9 13694.9 13942.8 13954.2 13972.1 13972.4 7963.7 8232.7 8304.3 8307.8 8313.1 4487.9 4607.6 4662.1 4683.6 4707.8 1577.8 1592.6 1607.9 1610.7 1622.7 20812.8 21566.7 22508.2 22800.9 22918.9 6372.6 6683.7 7349.4 7378.9 7591.2 19518.4 19760.9 19798.6 19837.8 19870.9 8192.9 8460.0 8474.1 8476.8 8485.4 7387.2 7579.4 7691.6 7694.1 7720.0 5407.8 5704.6 5713.5 5734.8 5771.4 1725.2 1753.6 1772.4 1789.2 1789.7 919.5 929.4 947.3 951.4 960.2 7551.2 7587.3 7694.7 7774.8 7784.3 748.0 758.1 764.1 771.3 781.1 5113.4 5599.1 5609.9 5616.2 5647.5 18847.4 19759.6 19878.5 19924.5 20015.9 20934.7 21187.5 21314.0 21359.1 21437.8 10813.2 11112.8 11153.2 11380.7 11386.6 8304.0 8370.6 8452.9 8595.4 8955.6 17347.1 17552.5 17842.6 17860.4 18151.2 17478.7 18458.3 18716.7 18781.1 18869.7 12467.6 12531.1 12578.3 12626.9 12659.1 13230.7 13396.5 13611.9 13639.7 13825.8 10385.5 10748.9 10968.9 11303.3 11550.0 11034.2 11101.1 11236.4 11264.9 11461.1 10178.2 10178.9 10204.2 10237.1 10341.6 7213.2 7319.5 7476.9 7542.4 7621.1 7629.7 7642.2 7663.3 7682.6 7787.7 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | [#4] prototype.html Cycles:180 Average:5569.78 Median:6193.12 stddev:1603.76 (25.9%) stddev-sans-first:1562.37 05:54:47 INFO - PID 12521 | Values: 495.2 512.4 525.7 529.3 530.6 6157.1 6172.5 6178.0 6197.0 6204.8 5854.4 6086.7 6092.3 6100.0 6121.5 4721.9 4754.1 4773.5 4803.1 4808.8 4752.8 4770.7 4777.4 4812.7 4814.0 4777.9 4786.9 4802.7 4805.2 4808.0 4583.0 4735.5 4738.5 4747.5 4803.6 4297.2 4300.4 4322.9 4325.8 4351.1 5951.9 5967.6 5975.1 5977.7 5991.3 5703.5 5737.9 5743.7 5747.3 5754.7 6564.9 6570.2 6583.7 6587.8 6593.0 4922.4 4932.1 4937.1 4958.9 4965.7 6818.8 6830.5 6862.7 6870.3 6883.8 5091.7 5096.3 5099.6 5107.8 5119.9 5159.6 5166.5 5168.9 5180.4 5194.7 5740.7 5765.0 5765.7 5770.9 5785.1 6464.0 6588.4 6607.3 6615.1 6632.1 1660.5 1780.2 1780.7 1802.9 1812.1 1224.5 1233.9 1248.1 1250.6 1251.3 6097.0 6187.9 6189.2 6240.2 6261.3 6488.4 6619.3 6694.0 6729.4 6763.0 6246.4 6259.6 6268.3 6292.4 6304.3 3493.2 3528.6 3542.5 3544.9 3553.9 7049.7 7135.3 7136.5 7171.9 7189.9 6833.9 6839.4 6858.0 6878.1 6882.2 7094.2 7153.2 7165.7 7177.2 7193.0 6651.4 6660.2 6689.5 6702.3 6746.5 6607.0 6637.6 6658.6 6675.6 6690.2 6955.8 7180.6 7182.4 7213.7 7215.0 5000.1 5041.4 5054.0 5055.8 5070.9 6745.7 6746.4 6754.5 6755.2 6760.0 6438.9 6464.7 6499.9 6507.3 6519.9 6456.4 6525.7 6551.0 6576.3 6583.9 6522.1 6529.5 6538.3 6545.8 6555.7 6555.5 6594.3 6596.0 6602.9 6608.3 6349.2 6369.3 6395.7 6408.6 6422.2 05:54:47 INFO - PID 12521 | 05:54:47 INFO - PID 12521 | [#5] yui.html Cycles:180 Average:23458.50 Median:20256.54 stddev:30742.61 (151.8%) stddev-sans-first:30781.88 05:54:47 INFO - PID 12521 | Values: 827.6 839.4 870.6 876.1 876.6 17482.8 17721.9 17939.6 18096.0 18132.8 16690.2 16767.6 17207.3 18622.0 19951.2 1031.6 1053.9 1057.2 1064.9 1066.1 1060.4 1060.5 1063.2 1064.7 1067.5 1137.6 1142.8 1143.6 1144.9 1145.7 1063.5 1082.9 1089.9 1135.5 1135.6 775.8 776.0 776.1 777.1 777.3 17232.3 17250.3 17265.9 17285.3 17374.9 19064.9 19964.8 20091.0 20153.3 20270.7 15655.9 16035.5 16039.8 16047.4 16233.0 3643.0 3645.2 3649.9 3675.3 3679.3 80326.6 110689.0 112803.0 116550.8 118311.0 13668.9 13937.7 16142.8 16618.0 16647.6 28414.4 28523.9 29325.9 29391.3 29577.0 8251.7 8286.8 8301.8 8347.2 8364.0 4108.8 4141.9 4145.1 4146.3 4150.2 4917.2 4954.1 4976.4 4981.6 5054.5 968.9 991.7 993.8 1006.2 1009.5 702.9 706.1 728.7 730.4 731.0 12913.6 13026.5 13153.6 13894.9 14884.8 711.3 722.2 730.3 749.6 761.4 5833.6 5917.8 5958.9 6122.6 6258.8 105854.5 108352.0 109987.0 111389.0 112046.4 91048.0 94523.0 95140.0 95671.0 97618.0 79740.2 85537.1 86959.0 89771.0 90935.0 13097.7 13914.1 13915.8 13972.2 14093.6 41320.6 41653.8 42414.4 43976.1 44392.0 74526.6 75248.6 75674.0 76690.6 77694.0 19316.9 19825.5 19872.8 20061.6 20242.4 20031.5 21089.9 21642.7 22325.2 22883.3 20916.4 20989.4 21222.3 21425.4 21557.6 18975.1 19595.5 20451.2 20687.4 21104.9 19807.3 19960.0 20026.2 20290.7 21025.3 12376.9 12494.7 12548.9 12561.3 12769.7 14096.0 15184.9 15493.2 15509.1 15894.5 05:54:47 INFO - PID 12521 | -------- Summary: end -------- 05:54:47 INFO - PID 12521 | 05:54:48 INFO - TEST-INFO | 12521: exit 0 05:54:48 INFO - TEST-OK | dromaeo_css | took 1114062ms 05:54:48 INFO - TEST-START | kraken 05:54:48 INFO - operating with platform_type : linux_ 05:54:48 INFO - Initialising browser for kraken test... 05:54:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36215/getInfo.html -profile /tmp/tmp5Tnc8R/profile 05:54:48 INFO - TEST-INFO | started process 12929 (/builds/slave/test/build/application/firefox/firefox http://localhost:36215/getInfo.html) 05:54:54 INFO - TEST-INFO | 12929: exit 0 05:54:54 INFO - Browser initialized. 05:54:54 INFO - Running cycle 1/1 for kraken test... 05:54:54 INFO - TEST-INFO | started process 13133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Tnc8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:05 INFO - PID 13133 | RSS: Main: 161783808 05:55:05 INFO - PID 13133 | 05:55:08 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36215/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:08 INFO - PID 13133 | RSS: Main: 166871040 05:55:08 INFO - PID 13133 | 05:55:11 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36215/tests/kraken/driver.html?testName=audio-dft) 05:55:12 INFO - PID 13133 | RSS: Main: 167251968 05:55:12 INFO - PID 13133 | 05:55:15 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36215/tests/kraken/driver.html?testName=audio-fft) 05:55:15 INFO - PID 13133 | RSS: Main: 161939456 05:55:15 INFO - PID 13133 | 05:55:17 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36215/tests/kraken/driver.html?testName=audio-oscillator) 05:55:18 INFO - PID 13133 | RSS: Main: 163356672 05:55:18 INFO - PID 13133 | 05:55:20 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:21 INFO - PID 13133 | RSS: Main: 162672640 05:55:21 INFO - PID 13133 | 05:55:24 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36215/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:24 INFO - PID 13133 | RSS: Main: 162971648 05:55:24 INFO - PID 13133 | 05:55:27 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36215/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:28 INFO - PID 13133 | RSS: Main: 166170624 05:55:28 INFO - PID 13133 | 05:55:31 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36215/tests/kraken/driver.html?testName=json-parse-financial) 05:55:31 INFO - PID 13133 | RSS: Main: 167006208 05:55:31 INFO - PID 13133 | 05:55:33 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:34 INFO - PID 13133 | RSS: Main: 166715392 05:55:34 INFO - PID 13133 | 05:55:35 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:36 INFO - PID 13133 | RSS: Main: 167436288 05:55:36 INFO - PID 13133 | 05:55:38 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:38 INFO - PID 13133 | RSS: Main: 167251968 05:55:38 INFO - PID 13133 | 05:55:41 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:42 INFO - PID 13133 | RSS: Main: 166969344 05:55:42 INFO - PID 13133 | 05:55:45 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:45 INFO - PID 13133 | RSS: Main: 167124992 05:55:45 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:36215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36215/tests/kraken/driver.html?testName=ai-astar) 05:55:47 INFO - PID 13133 | RSS: Main: 168972288 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | __start_tp_report 05:55:47 INFO - PID 13133 | _x_x_mozilla_page_load 05:55:47 INFO - PID 13133 | _x_x_mozilla_page_load_details 05:55:47 INFO - PID 13133 | |i|pagename|runs| 05:55:47 INFO - PID 13133 | |0;ai-astar;99;106;106;103;105;108;106;105;106;108 05:55:47 INFO - PID 13133 | |1;audio-beat-detection;142;115;148;162;117;147;151;139;169;117 05:55:47 INFO - PID 13133 | |2;audio-dft;163;166;163;161;162;162;161;159;169;163 05:55:47 INFO - PID 13133 | |3;audio-fft;75;76;74;160;74;74;80;74;97;74 05:55:47 INFO - PID 13133 | |4;audio-oscillator;81;81;133;80;81;81;137;82;81;138 05:55:47 INFO - PID 13133 | |5;imaging-gaussian-blur;114;114;114;114;114;114;113;113;114;113 05:55:47 INFO - PID 13133 | |6;imaging-darkroom;148;148;147;146;148;147;147;148;147;147 05:55:47 INFO - PID 13133 | |7;imaging-desaturate;93;94;94;94;94;95;94;94;94;94 05:55:47 INFO - PID 13133 | |8;json-parse-financial;52;49;46;46;46;46;49;46;46;49 05:55:47 INFO - PID 13133 | |9;json-stringify-tinderbox;55;55;54;54;54;54;53;54;54;54 05:55:47 INFO - PID 13133 | |10;stanford-crypto-aes;75;76;76;74;73;74;75;75;74;75 05:55:47 INFO - PID 13133 | |11;stanford-crypto-ccm;120;129;122;118;120;120;117;123;120;158 05:55:47 INFO - PID 13133 | |12;stanford-crypto-pbkdf2;169;171;192;171;190;168;170;178;173;169 05:55:47 INFO - PID 13133 | |13;stanford-crypto-sha256-iterative;65;69;61;60;61;60;59;63;63;59 05:55:47 INFO - PID 13133 | __end_tp_report 05:55:47 INFO - PID 13133 | __start_cc_report 05:55:47 INFO - PID 13133 | _x_x_mozilla_cycle_collect,824 05:55:47 INFO - PID 13133 | __end_cc_report 05:55:47 INFO - PID 13133 | __startTimestamp1498654547615__endTimestamp 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | ------- Summary: start ------- 05:55:47 INFO - PID 13133 | Number of tests: 14 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#0] ai-astar Cycles:10 Average:105.20 Median:106.00 stddev:2.62 (2.5%) stddev-sans-first:1.54 05:55:47 INFO - PID 13133 | Values: 99.0 106.0 106.0 103.0 105.0 108.0 106.0 105.0 106.0 108.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:147.50 stddev:18.98 (12.9%) stddev-sans-first:20.13 05:55:47 INFO - PID 13133 | Values: 142.0 115.0 148.0 162.0 117.0 147.0 151.0 139.0 169.0 117.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.81 (1.7%) stddev-sans-first:2.98 05:55:47 INFO - PID 13133 | Values: 163.0 166.0 163.0 161.0 162.0 162.0 161.0 159.0 169.0 163.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#3] audio-fft Cycles:10 Average:85.80 Median:74.50 stddev:27.03 (36.3%) stddev-sans-first:28.38 05:55:47 INFO - PID 13133 | Values: 75.0 76.0 74.0 160.0 74.0 74.0 80.0 74.0 97.0 74.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:81.00 stddev:26.60 (32.8%) stddev-sans-first:27.54 05:55:47 INFO - PID 13133 | Values: 81.0 81.0 133.0 80.0 81.0 81.0 137.0 82.0 81.0 138.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:55:47 INFO - PID 13133 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:55:47 INFO - PID 13133 | Values: 148.0 148.0 147.0 146.0 148.0 147.0 147.0 148.0 147.0 147.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:55:47 INFO - PID 13133 | Values: 93.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:2.12 (4.5%) stddev-sans-first:1.50 05:55:47 INFO - PID 13133 | Values: 52.0 49.0 46.0 46.0 46.0 46.0 49.0 46.0 46.0 49.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 05:55:47 INFO - PID 13133 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 53.0 54.0 54.0 54.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 05:55:47 INFO - PID 13133 | Values: 75.0 76.0 76.0 74.0 73.0 74.0 75.0 75.0 74.0 75.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:121.00 stddev:12.16 (10.0%) stddev-sans-first:12.77 05:55:47 INFO - PID 13133 | Values: 120.0 129.0 122.0 118.0 120.0 120.0 117.0 123.0 120.0 158.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:172.00 stddev:8.85 (5.1%) stddev-sans-first:9.11 05:55:47 INFO - PID 13133 | Values: 169.0 171.0 192.0 171.0 190.0 168.0 170.0 178.0 173.0 169.0 05:55:47 INFO - PID 13133 | 05:55:47 INFO - PID 13133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:3.13 (5.0%) stddev-sans-first:3.12 05:55:47 INFO - PID 13133 | Values: 65.0 69.0 61.0 60.0 61.0 60.0 59.0 63.0 63.0 59.0 05:55:47 INFO - PID 13133 | -------- Summary: end -------- 05:55:47 INFO - PID 13133 | 05:55:48 INFO - TEST-INFO | 13133: exit 0 05:55:48 INFO - TEST-OK | kraken | took 60334ms 05:55:48 INFO - SUITE-END | took 1174s 05:55:48 INFO - Completed test suite (00:19:34) 05:55:48 INFO - javascript benchmark 05:55:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8580.734138051805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.2923721399893, 3341.7493687973406, 3348.531205631212, 3350.798952062876, 3374.1395944034284, 6105.297890742566, 6123.112148738436, 6126.969365153179, 6134.079888016789, 6140.048292514656, 6144.047672610742, 6162.106494558287, 6191.690415479219, 6197.752089916398, 6207.782727604535, 5390.19147127932, 5408.161734931092, 5410.675359478424, 5437.8368648940595, 5523.199136125259, 5416.566674666037, 5465.754041068161, 5493.917591236134, 5511.807086751965, 5519.448055194469, 5350.170723537819, 5376.11294136467, 5438.211459338374, 5439.619226654136, 5441.347038355383, 5368.1679339702405, 5401.297831281948, 5429.294191755086, 5429.348478182604, 5433.701146436944, 5307.761150748225, 5370.516653501204, 5380.542653874425, 5394.757235924393, 5400.432954539795, 6058.636481811105, 6095.238095238095, 6104.908426373608, 6110.266767987825, 6121.846953826145, 6523.5107366947195, 6677.966610166966, 6688.63212523311, 6725.798226053226, 6726.562773419712, 6685.465162786965, 6705.6982435790505, 6724.932750672479, 6745.662716864186, 6746.055552222692, 6175.413335733098, 6191.504679625664, 6220.533459990519, 6229.906551401642, 6239.032949892774, 6770.729170833111, 6786.796396108125, 6834.453243740588, 6858.965705171442, 6889.827754306082, 6472.935270647327, 6505.707243174069, 6538.72494863497, 6546.869062618816, 6548.574342667712, 6598.241202261705, 6605.70274337656, 6640.535162538576, 6671.633060181736, 6698.095757072831, 6665.566738162004, 6692.0, 6715.630640314829, 6716.664166791738, 6721.966390168018, 6662.200535935622, 6731.32686731323, 6755.628440435725, 6757.3242675732035, 6769.695363708645, 5107.33604631403, 5118.053160165381, 5133.614978876599, 5136.5377116059735, 5149.613778966593, 4418.403515525363, 4436.511983681792, 4439.66702497314, 4477.574630410106, 4489.0572979674635, 6161.322254551996, 6272.6236425814595, 6301.117843501914, 6317.084022816758, 6319.273283572356, 6751.223609284897, 6796.218434879953, 6803.727850885909, 6809.182898052166, 6815.42068924147, 6318.115463834974, 6362.586431881913, 6363.459105975951, 6371.872562548816, 6388.137601423841, 5763.337216220105, 5809.128630705343, 5831.504322132581, 5840.182374467578, 5863.384344643836, 7102.893456598258, 7118.145822501229, 7145.714171433085, 7183.281671832775, 7188.353048225685, 6724.193096828412, 6770.695318710768, 6787.694553745192, 6824.249332573512, 6830.112085428863, 7154.0, 7161.176464706417, 7170.784876453506, 7218.061651985208, 7231.63841807897, 6645.401913827585, 6657.900131497934, 6668.399844014062, 6676.866462670817, 6688.097106890507, 6643.701033453603, 6695.263521012782, 6732.293109223461, 6734.3602357775935, 6827.04421381017, 6532.05285233648, 6573.211214654272, 6584.209894812653, 6615.470762338905, 6628.038934354395, 6512.34876512345, 6535.705893234721, 6572.671366431755, 6587.47300215972, 6597.175353080865, 6437.871242575216, 6549.0, 6561.1470508833545, 6577.473802095917, 6587.077809106825, 6463.709133089116, 6478.4169424752, 6572.8356791080605, 6605.603663780189, 6649.168853893263, 6359.904601431075, 6387.840303992437, 6390.968045159744, 6414.262359828679, 6435.324290949383], "value": 6115.927232971394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.9215270625642, 931.1386967055467, 957.3920560444118, 958.966436174734, 986.674397448842, 42752.57247427529, 43552.564474355284, 43849.78075109628, 43921.560784392146, 44211.55788442115, 40128.59871401285, 40340.39489407661, 40802.183956320856, 40858.59141408585, 40875.0, 6745.797626071213, 6833.214180369271, 6849.863002739942, 6859.451243900476, 6860.5540639858245, 6702.966485167567, 6721.227058888241, 6744.797656070301, 6770.289119642441, 6777.661116944158, 6740.898886516707, 6767.864642707143, 6793.5584187027935, 6825.0, 6834.179898412172, 6773.221079575838, 6802.115724955774, 6814.386705196556, 6817.386435220829, 6818.045473633695, 6313.905291420632, 6324.304326524125, 6353.459955903753, 6366.267879193906, 6377.202849643794, 35642.28715425677, 35808.82095589532, 35862.10344741376, 35865.64134358649, 35902.28195436077, 3420.538227339327, 3459.705924996378, 3496.7552271341015, 3583.7670551414335, 3589.730770192246, 32147.357052858813, 32508.0, 32614.347713045845, 32640.347193056004, 32666.0, 3820.331441997639, 3821.14024344523, 3851.9037024074623, 3854.2869569129803, 3891.455196272524, 215119.0, 215630.0, 219978.0, 220021.0, 221431.0, 48898.26652600214, 53916.0, 54640.726796365765, 54808.451915481135, 55208.0, 57472.0, 57521.137182942286, 57523.0, 57779.71110144423, 58124.0, 15979.680406391806, 16151.919240403722, 16184.838151618333, 16234.350625974828, 16260.75608865868, 13099.738005240033, 13153.342332883318, 13162.539311124065, 13185.53850615224, 13230.536931207362, 15715.21423928799, 15849.890507664584, 15897.364105435885, 15960.920195398949, 16019.199040047952, 6014.909776353358, 6070.969645151746, 6233.379321376384, 6249.218847644044, 6254.781082662085, 1061.5859814672283, 1066.7173199102244, 1087.2932593814085, 1092.251807511857, 1101.4767985207122, 24667.506649866904, 24850.751492485204, 24935.37661558439, 25296.36759081001, 25338.239852804076, 1151.642990672894, 1158.0966845860241, 1167.5971789732528, 1172.7478592102568, 1179.3985067615579, 12994.935025324812, 13193.0, 13212.141210821266, 13306.600801975956, 17070.317187312616, 265839.0, 267670.0, 269114.0, 269282.0, 270095.0, 62625.373746261954, 62887.371126289065, 62915.37084629095, 63125.684371577845, 63129.0, 1461.8684318411395, 1519.1948267418286, 1519.5213507745025, 1524.4465520253532, 1531.4486784757478, 28597.99907003245, 29447.85276073606, 29454.11637650874, 29996.70003299939, 30012.699873001864, 42336.0, 42507.574924251596, 42569.78715106405, 42585.361219581115, 42628.0, 230768.0, 231524.0, 231772.0, 232181.0, 233424.0, 33143.50284745779, 33822.154446139044, 33864.661353387135, 33905.0, 36682.0, 43688.0, 45213.0, 45273.09453810971, 45598.860028499555, 46063.76968115138, 34057.48913766345, 34218.48672269868, 34395.484067739504, 34463.13842153866, 34611.653883460844, 33162.517935616415, 33458.66541334555, 34012.65987340194, 34173.0, 34578.82710586431, 39109.804450977565, 39498.60501394949, 39504.407433889086, 39639.603603963595, 39857.2028559433, 32008.83995580007, 33111.83444082764, 33115.17212069621, 33219.33561328808, 33519.664803351654, 24394.634080488453, 24601.384965376008, 24609.753902461463, 25116.874415627804, 25392.365190870376], "value": 17759.521230300685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5782734035803, 562.5977426140308, 565.1607363065849, 570.8572856785804, 582.3594046548797, 22180.223692170777, 23272.41818954527, 23297.417564560896, 23313.0, 23359.416014599643, 22112.115515379406, 22376.552468950613, 23269.185578504756, 23379.298621041355, 23550.41123971897, 6251.843703907393, 6417.711202995876, 6418.0, 6433.871322573569, 6454.580452270611, 6152.200213972177, 6166.136740856284, 6171.4445699887, 6175.197224360827, 6191.752329906798, 5808.883822323551, 6104.847378815543, 6156.876862462748, 6182.412670796267, 6188.443040126388, 6173.691315434233, 6185.690715464231, 6202.565820392551, 6214.440700336946, 6227.221597300338, 5803.303603567557, 5809.128630705386, 5810.331811841608, 5812.941870581282, 5819.970900145515, 29889.850550747324, 30194.245143871358, 30208.395832083235, 30209.848950755324, 30228.8488557558, 2203.46015226269, 2278.362058623588, 2305.9968913522503, 2313.8958746856433, 2326.1044497868443, 19446.51383715404, 19491.80508194914, 19674.114664839974, 19716.408507744647, 19738.70391944122, 2366.89299814641, 2421.479381932893, 2457.8648174350405, 2463.310273123528, 2464.5440593490084, 136513.0, 139985.0, 140459.0, 140882.0, 141451.29274353563, 15057.54827355181, 15190.405007474055, 15300.846991529943, 15417.383304667912, 15643.530694078969, 23569.17507887216, 23589.0, 23631.881840590686, 23635.40911477227, 23659.645105323434, 9736.805263894683, 9747.122758951728, 9905.702828915144, 9930.751731206634, 9942.552585133686, 8782.91217087821, 8786.60460279289, 8897.466152030898, 8915.420497667761, 8940.776480587907, 9481.288903332139, 9493.0, 9527.142557169887, 9572.856407153899, 9675.806483870283, 2647.7484638959268, 2709.051831858834, 2763.1710486854267, 2782.791290653209, 2787.28924124347, 1022.539857064324, 1026.7381817636604, 1046.5186014433293, 1050.485262221506, 1054.2725519391595, 20639.4840128995, 20865.0, 21020.78979210219, 21199.78800212009, 21309.36071917814, 1081.7566047639375, 1084.1110289562641, 1088.7876864011441, 1111.2554588425774, 1113.7438389170536, 10965.780684386267, 11620.76758464826, 11622.476988535536, 11650.6504804856, 11697.941510292394, 550269.0, 558127.0, 575286.0, 577418.0, 590232.0, 116601.0, 117755.0, 118589.0, 119252.0, 119495.40252298857, 1213.9210951288137, 1217.6103646833105, 1217.7077501399601, 1228.3612521488776, 1229.26244253449, 17732.202050907483, 18405.447836564923, 18646.254149834396, 18697.813021869606, 18760.718589221444, 53137.7343113282, 53147.20279195892, 54251.45748542464, 54629.45370546244, 54766.72616636891, 70082.0, 70724.0, 71179.64410177917, 71613.28386716066, 72944.27055729587, 12764.17032892859, 13142.145760525535, 13205.537806176737, 13279.601611951657, 13355.933220333836, 19377.128029238436, 19388.515287117934, 19544.511387214865, 19545.21819127219, 19745.40763777089, 14716.55850324492, 16335.67328653444, 16506.75239871379, 16549.420770272984, 16621.75067373966, 14043.719125617636, 14413.279336033365, 14690.55928322152, 15074.794016478874, 15408.075515469107, 15965.760513592537, 16518.66962660764, 16770.24533896002, 16924.23840927186, 17048.31806727717, 12876.22742635445, 13097.345132743516, 13130.343482825629, 13253.13854599448, 13255.072144949761, 16314.67370652604, 16317.755233671267, 16417.67164656724, 16443.67112657764, 16519.66960660756], "value": 11768.016787350925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.391264799812, 1460.3793387810185, 1462.846401127881, 1465.8754005909498, 1470.6396932751484, 14554.490592829254, 15131.0, 15261.465848695298, 15271.465498707548, 15296.69406611867, 14503.709925801504, 14965.176915269656, 15004.849951500482, 15031.173285469295, 15046.699066018673, 2637.340664833787, 2677.4912766574384, 2690.5291573974573, 2697.3121853927223, 2700.648915640964, 2583.922482325524, 2678.8526631035284, 2680.463907218564, 2681.383281845167, 2684.3691732442862, 2656.734326567347, 2676.9464610707773, 2692.838429694215, 2694.0840114361113, 2699.2981824725616, 2601.0896186334726, 2608.7391260873856, 2610.0864697355964, 2615.0193677370985, 2619.332070322065, 2556.4759224358963, 2576.6521519594803, 2586.2499875036406, 2586.4697736964067, 2589.9482010359875, 13694.863051369559, 13942.790858137136, 13954.162750235018, 13972.091814032055, 13972.371243294076, 7963.721269755589, 8232.670693172266, 8304.335653147733, 8307.792305192419, 8313.08556058833, 4487.932681009787, 4607.631389488833, 4662.114198302345, 4683.601893839028, 4707.811687532529, 1577.771223172645, 1592.5859276588055, 1607.9356825726957, 1610.7181243282496, 1622.7160246956735, 20812.791872081387, 21566.676499852514, 22508.21221257248, 22800.885995570083, 22918.885405572866, 6372.649504277217, 6683.699233534503, 7349.448791340671, 7378.889316660255, 7591.164971853092, 19518.414447566596, 19760.90119549393, 19798.604027919362, 19837.801621983883, 19870.90064549668, 8192.877106843402, 8460.0, 8474.1102184271, 8476.788080297918, 8485.40602157843, 7387.150477695134, 7579.355754760797, 7691.576963266962, 7694.115176754633, 7720.0, 5407.810726624628, 5704.600677952587, 5713.457221563945, 5734.827955161351, 5771.365149833515, 1725.1546742096282, 1753.587906841891, 1772.4151030160017, 1789.168036862839, 1789.6689112514227, 919.5080631861922, 929.3680297397834, 947.3131979314942, 951.362587066667, 960.2414092866558, 7551.207123251979, 7587.317141457185, 7694.730684426018, 7774.844503109906, 7784.260495252942, 747.9626018699043, 758.0940775773008, 764.0792844622217, 771.3058247577113, 781.0549235425199, 5113.411957624847, 5599.1041433370465, 5609.915851262234, 5616.241807355955, 5647.519960803378, 18847.434576962714, 19759.60480790405, 19878.50303742418, 19924.50188745264, 20015.899920500597, 20934.685979710317, 21187.470313241985, 21314.0, 21359.14563417477, 21437.78562214358, 10813.18901082422, 11112.777744445228, 11153.163512736577, 11380.715482112848, 11386.601468948713, 8304.0, 8370.58147092655, 8452.873206902024, 8595.355348348774, 8955.59699813497, 17347.132643367528, 17552.473425797245, 17842.5539361517, 17860.374886878897, 18151.183196755912, 17478.650426991644, 18458.26166953307, 18716.719249211546, 18781.060946952326, 18869.71695424542, 12467.625971220878, 12531.122821402414, 12578.30819304947, 12626.873731262569, 12659.050571207381, 13230.735385292048, 13396.531121410704, 13611.863881361456, 13639.659008524866, 13825.79261311061, 10385.532651030873, 10748.946255268673, 10968.945155274172, 11303.265287756269, 11550.0, 11034.227604067639, 11101.11191104726, 11236.438178090899, 11264.887351126712, 11461.140414468782, 10178.18574514052, 10178.898211018091, 10204.183665306906, 10237.078662920372, 10341.63804266847, 7213.242609526134, 7319.5242309249725, 7476.925230747623, 7542.396608271215, 7621.085469743666, 7629.7329593463965, 7642.235776422313, 7663.31030207284, 7682.615869206629, 7787.688492460238], "value": 6615.985353790592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.18047631170424, 512.3672264753029, 525.6740820691169, 529.3066083430706, 530.6046994988734, 6157.076438534216, 6172.537059720522, 6177.980633195517, 6197.008478643418, 6204.844878878031, 5854.38528954459, 6086.695665216744, 6092.329843717188, 6100.0, 6121.510279177666, 4721.929171062419, 4754.096721622889, 4773.474917759044, 4803.111424386482, 4808.783604737778, 4752.7861246244, 4770.689905156171, 4777.355057067286, 4812.663113582051, 4814.013127308911, 4777.90444191116, 4786.928196077061, 4802.663813533054, 4805.231163013918, 4807.975960120195, 4582.954170458286, 4735.455422626407, 4738.549837765407, 4747.477777444478, 4803.615710743132, 4297.226499230137, 4300.35494675798, 4322.854443572456, 4325.805338759764, 4351.129774045204, 5951.880962380771, 5967.641941483482, 5975.133605627203, 5977.671228082454, 5991.3109992351, 5703.5437165027115, 5737.913931291034, 5743.741531631086, 5747.252857128588, 5754.6547207167705, 6564.934350656527, 6570.244421891496, 6583.6708164592055, 6587.814193445178, 6592.967035164794, 4922.360093187898, 4932.062908047459, 4937.086638971766, 4958.851234462972, 4965.726885021322, 6818.761343352959, 6830.521863469559, 6862.691178896912, 6870.27862074485, 6883.793486195422, 5091.719955402488, 5096.337476128154, 5099.617528685363, 5107.795688172506, 5119.897602047939, 5159.638825282194, 5166.509181627739, 5168.8966220675375, 5180.352455943007, 5194.68831870089, 5740.712964351766, 5765.0, 5765.711714414262, 5770.913436298459, 5785.074388097884, 6464.0, 6588.374104460068, 6607.306232845578, 6615.140031795836, 6632.104665870046, 1660.5433505785763, 1780.2256018631936, 1780.6705759434547, 1802.8828126171757, 1812.1301775148004, 1224.5469176404608, 1233.8827811357908, 1248.1013670157472, 1250.612310183846, 1251.3232268759723, 6096.969515152396, 6187.938120618826, 6189.226346706661, 6240.188775459162, 6261.342559031327, 6488.383603557654, 6619.271880093186, 6694.0, 6729.360710732472, 6762.966185169141, 6246.437820596168, 6259.561830671901, 6268.341824108403, 6292.370762923671, 6304.306526282197, 3493.1965647901125, 3528.6471352865024, 3542.4509201073874, 3544.858205671744, 3553.911152221215, 7049.718011279491, 7135.250798666066, 7136.536125151849, 7171.856562868714, 7189.928100718926, 6833.897491537531, 6839.350261725128, 6858.039874417485, 6878.105846239957, 6882.208546017172, 7094.219635840053, 7153.213146553875, 7165.713371465083, 7177.246389129171, 7192.950009247339, 6651.368120028589, 6660.200775906922, 6689.49828762835, 6702.262751097278, 6746.4940129489505, 6606.966965165144, 6637.601743895381, 6658.600483970978, 6675.599464032173, 6690.230623478362, 6955.756548520778, 7180.5691658500655, 7182.35358817688, 7213.747518836815, 7215.015870635617, 5000.14997450427, 5041.4454410015605, 5053.974730126326, 5055.797768089235, 5070.898582028412, 6745.696443659949, 6746.392824645609, 6754.547772228994, 6755.1556055493065, 6760.0, 6438.903416448663, 6464.7393758216695, 6499.870002599827, 6507.28419873823, 6519.924212504883, 6456.418922297016, 6525.738970441319, 6550.984597387413, 6576.342365763386, 6583.9465685490095, 6522.119513865568, 6529.51028672861, 6538.313477085027, 6545.803625891231, 6555.704993275219, 6555.475561955128, 6594.307597702172, 6595.967020164869, 6602.933970660232, 6608.306127856698, 6349.206349206349, 6369.299377068612, 6395.7121929514215, 6408.61548307103, 6422.197225346832], "value": 5099.426641929386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.5737994932609, 839.4249938791925, 870.6082262981656, 876.1413814461828, 876.6449587916892, 17482.825171748278, 17721.911390443063, 17939.641207175864, 18096.0, 18132.81867181328, 16690.165491725395, 16767.580810479743, 17207.311707531684, 18622.0, 19951.201951921907, 1031.5976769060073, 1053.8682664666917, 1057.1912486947492, 1064.920130990179, 1066.0991462214456, 1060.363781730959, 1060.4750648429037, 1063.1654151491043, 1064.739138910968, 1067.4822710985165, 1137.562038615135, 1142.8342890280903, 1143.5654451308492, 1144.914131440141, 1145.73075327298, 1063.494839951025, 1082.9350238985608, 1089.9400532970683, 1135.5060548661318, 1135.6309199510151, 775.7711475114854, 776.0377132355894, 776.0687175389555, 777.0985656638329, 777.3237283563336, 17232.310707571683, 17250.30998760048, 17265.91367043169, 17285.30858765648, 17374.913125434417, 19064.856108633525, 19964.80035199644, 20091.0, 20153.294634687714, 20270.69593956077, 15655.92172039144, 16035.518934431986, 16039.759403608838, 16047.35810567576, 16233.0, 3643.0, 3645.179834537208, 3649.872254471081, 3675.2833197526493, 3679.2825399047197, 80326.59836700838, 110689.0, 112803.0, 116550.83449165485, 118311.0, 13668.93165534166, 13937.721245575032, 16142.75785863213, 16617.99999999976, 16647.583810404838, 28414.431711365658, 28523.85738071338, 29325.85337073301, 29391.26521836971, 29577.0, 8251.711190108317, 8286.751397458085, 8301.8339633207, 8347.248747612623, 8363.95818020906, 4108.794560271975, 4141.937870931938, 4145.108801607669, 4146.295129827937, 4150.190712811033, 4917.164082105979, 4954.083494553519, 4976.353074100416, 4981.626378021663, 5054.494550544916, 968.864358989742, 991.6727479931606, 993.7764003099389, 1006.225206590921, 1009.5103874620803, 702.9437644988388, 706.0715159565156, 728.6575309604477, 730.422965856967, 731.0459849895936, 12913.612591622266, 13026.54407095766, 13153.60539183826, 13894.93052534751, 14884.776728349083, 711.3349018667562, 722.2019668266595, 730.3317464519905, 749.57274353619, 761.4213197969473, 5833.591648584643, 5917.822465326047, 5958.880822383615, 6122.602030867979, 6258.812235632939, 105854.47072764586, 108352.0, 109987.0, 111389.0, 112046.43976780064, 91048.0, 94523.0, 95140.0, 95671.0, 97618.0, 79740.20259797444, 85537.14462855416, 86959.0, 89771.0, 90935.0, 13097.738045239232, 13914.09558378702, 13915.791263131263, 13972.231527266098, 14093.577192684235, 41320.586794131676, 41653.79173104115, 42414.36378454264, 43976.12047759091, 44392.0, 74526.62736686281, 75248.62375688087, 75674.0, 76690.6165469169, 77694.0, 19316.903415482833, 19825.504362391057, 19872.81399046075, 20061.598768024265, 20242.392728218176, 20031.499212519222, 21089.894550527148, 21642.6753598693, 22325.218617348313, 22883.31350059501, 20916.37250882476, 20989.37031889046, 21222.25722099719, 21425.357239282846, 21557.568848622625, 18975.14611842498, 19595.510112247306, 20451.181952721723, 20687.379378618665, 21104.894475527522, 19807.306744263882, 19960.0, 20026.198952042338, 20290.69563956512, 21025.264115755876, 12376.938115309365, 12494.687632809253, 12548.874511254771, 12561.309127998047, 12769.680757980754, 14096.0, 15184.937054406528, 15493.218279897956, 15509.146996915279, 15894.52316430509], "value": 9255.663004207043, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 106.0, 103.0, 105.0, 108.0, 106.0, 105.0, 106.0, 108.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 148.0, 162.0, 117.0, 147.0, 151.0, 139.0, 169.0, 117.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 161.0, 162.0, 162.0, 161.0, 159.0, 169.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 160.0, 74.0, 74.0, 80.0, 74.0, 97.0, 74.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 133.0, 80.0, 81.0, 81.0, 137.0, 82.0, 81.0, 138.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 46.0, 46.0, 46.0, 46.0, 49.0, 46.0, 46.0, 49.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 74.0, 73.0, 74.0, 75.0, 75.0, 74.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 129.0, 122.0, 118.0, 120.0, 120.0, 117.0, 123.0, 120.0, 158.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 192.0, 171.0, 190.0, 168.0, 170.0, 178.0, 173.0, 169.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 61.0, 60.0, 61.0, 60.0, 59.0, 63.0, 63.0, 59.0], "value": 62.0, "unit": "score"}]}]} 05:55:48 INFO - Return code: 0 05:55:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:55:48 INFO - # TBPL SUCCESS # 05:55:48 INFO - Running post-action listener: _resource_record_post_action 05:55:48 INFO - [mozharness: 2017-06-28 12:55:48.999945Z] Finished run-tests step (success) 05:55:49 INFO - Running post-run listener: _resource_record_post_run 05:55:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 49152; Write bytes: 436150272; Read time: 360; Write time: 327904 05:55:49 INFO - TinderboxPrint: CPU usage
13.0% 05:55:49 INFO - TinderboxPrint: I/O read bytes / time
49,152 / 360 05:55:49 INFO - TinderboxPrint: I/O write bytes / time
436,150,272 / 327,904 05:55:49 INFO - TinderboxPrint: CPU idle
8,275.1 (87.0%) 05:55:49 INFO - TinderboxPrint: CPU user
1,193.8 (12.5%) 05:55:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:55:49 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 49152; Write bytes: 113954816; Read time: 360; Write time: 130864 05:55:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:55:49 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 322195456; Read time: 0; Write time: 197040 05:55:49 INFO - Running post-run listener: _upload_blobber_files 05:55:49 INFO - Blob upload gear active. 05:55:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:55:49 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 05:55:49 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'] 05:55:49 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 05:55:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:55:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:55:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:55:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:54 INFO - (blobuploader) - INFO - Done attempting. 05:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:55:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:55 INFO - (blobuploader) - INFO - Done attempting. 05:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:56 INFO - (blobuploader) - INFO - Done attempting. 05:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:57 INFO - (blobuploader) - INFO - Done attempting. 05:55:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:55:57 INFO - Return code: 0 05:55:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:55:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:55:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ff7b878ffde2e6e6aafdb34d37228f7061783a048e02dc5ee329d5809da33d1758199a7001fb976348f33a5f888c8392d0dfc8394f0a23a4e3d6d323eb304ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/875134efe7bb2aef12efc9469c1ddea7674fcf69438616ef8d3f2e5e80560faba9de99ff81e9ec48339dd32e894578d28839c814213d69bb09ad31477f231b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b045ddbfc3d2031472588619e2c695d34df648f45814beb81541a5d067fc9ada9b79499f400c0c7a6566135808cc4cab8f7c69307fc6316963addf0b77cfe56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e92e67c5b57381489a6623f49aca733d4ecd98e64c2ca32686248d11fa4efb5c7f1555b08b0ea62aff6f30d938c955b628c36c6186862bc64f479619d5255d75"} 05:55:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:55:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:55:57 INFO - Contents: 05:55:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ff7b878ffde2e6e6aafdb34d37228f7061783a048e02dc5ee329d5809da33d1758199a7001fb976348f33a5f888c8392d0dfc8394f0a23a4e3d6d323eb304ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/875134efe7bb2aef12efc9469c1ddea7674fcf69438616ef8d3f2e5e80560faba9de99ff81e9ec48339dd32e894578d28839c814213d69bb09ad31477f231b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b045ddbfc3d2031472588619e2c695d34df648f45814beb81541a5d067fc9ada9b79499f400c0c7a6566135808cc4cab8f7c69307fc6316963addf0b77cfe56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e92e67c5b57381489a6623f49aca733d4ecd98e64c2ca32686248d11fa4efb5c7f1555b08b0ea62aff6f30d938c955b628c36c6186862bc64f479619d5255d75"} 05:55:57 INFO - Running post-run listener: copy_logs_to_upload_dir 05:55:57 INFO - Copying logs to upload dir... 05:55:57 INFO - mkdir: /builds/slave/test/build/upload/logs 05:55:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.686725 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-06-28 05:55:57.635084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-28 05:55:57.640078) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549 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/6ff7b878ffde2e6e6aafdb34d37228f7061783a048e02dc5ee329d5809da33d1758199a7001fb976348f33a5f888c8392d0dfc8394f0a23a4e3d6d323eb304ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/875134efe7bb2aef12efc9469c1ddea7674fcf69438616ef8d3f2e5e80560faba9de99ff81e9ec48339dd32e894578d28839c814213d69bb09ad31477f231b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b045ddbfc3d2031472588619e2c695d34df648f45814beb81541a5d067fc9ada9b79499f400c0c7a6566135808cc4cab8f7c69307fc6316963addf0b77cfe56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e92e67c5b57381489a6623f49aca733d4ecd98e64c2ca32686248d11fa4efb5c7f1555b08b0ea62aff6f30d938c955b628c36c6186862bc64f479619d5255d75"} build_url:https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/HM975nGcSU22KjrIpZs36w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ff7b878ffde2e6e6aafdb34d37228f7061783a048e02dc5ee329d5809da33d1758199a7001fb976348f33a5f888c8392d0dfc8394f0a23a4e3d6d323eb304ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/875134efe7bb2aef12efc9469c1ddea7674fcf69438616ef8d3f2e5e80560faba9de99ff81e9ec48339dd32e894578d28839c814213d69bb09ad31477f231b5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b045ddbfc3d2031472588619e2c695d34df648f45814beb81541a5d067fc9ada9b79499f400c0c7a6566135808cc4cab8f7c69307fc6316963addf0b77cfe56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e92e67c5b57381489a6623f49aca733d4ecd98e64c2ca32686248d11fa4efb5c7f1555b08b0ea62aff6f30d938c955b628c36c6186862bc64f479619d5255d75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-28 05:55:57.666819) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:55:57.667174) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1498653013.558716-1448791549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:55:57.747385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-28 05:55:57.750707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-28 05:55:57.750988) ========= ========= Total master_lag: 0.20 =========