builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1501419271.81 results: success (0) revision: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.812622) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.812995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:31.813256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.123964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.124414) ========= 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=0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 05:54:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-07-30 05:54:33 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142614 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.299052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.299348) ========= 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=0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023584 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.353228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.353518) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 --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 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 --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=0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 05:54:33,441 truncating revision to first 12 chars 2017-07-30 05:54:33,442 Setting DEBUG logging. 2017-07-30 05:54:33,442 attempt 1/10 2017-07-30 05:54:33,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d1b50a370b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 05:54:33,710 unpacking tar archive at: mozilla-central-6d1b50a370b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.923643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.923945) ========= script_repo_revision: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.924314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.924580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 05:54:32.939078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-30 05:54:32.939414) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:34 INFO - MultiFileLogger online at 20170730 05:54:34 in /builds/slave/test 05:54:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:34 INFO - {'append_to_log': False, 05:54:34 INFO - 'base_work_dir': '/builds/slave/test', 05:54:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:34 INFO - 'branch': 'Firefox-Non-PGO', 05:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:34 INFO - 'code_coverage': False, 05:54:34 INFO - 'config_files': ('talos/linux_config.py',), 05:54:34 INFO - 'default_actions': ('clobber', 05:54:34 INFO - 'read-buildbot-config', 05:54:34 INFO - 'download-and-extract', 05:54:34 INFO - 'populate-webroot', 05:54:34 INFO - 'create-virtualenv', 05:54:34 INFO - 'install', 05:54:34 INFO - 'setup-mitmproxy', 05:54:34 INFO - 'run-tests'), 05:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:34 INFO - 'disable_ccov_upload': False, 05:54:34 INFO - 'download_minidump_stackwalk': True, 05:54:34 INFO - 'download_symbols': 'ondemand', 05:54:34 INFO - 'enable_stylo': False, 05:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:34 INFO - 'gecko_profile': False, 05:54:34 INFO - 'gecko_profile_interval': 0, 05:54:34 INFO - 'installer_path': 'installer.exe', 05:54:34 INFO - 'log_level': 'info', 05:54:34 INFO - 'log_name': 'talos', 05:54:34 INFO - 'log_to_console': True, 05:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:34 INFO - 'opt_config_files': (), 05:54:34 INFO - 'pip_index': False, 05:54:34 INFO - 'suite': 'dromaeojs-e10s', 05:54:34 INFO - 'system_bits': '32', 05:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:34 INFO - 'title': 'talos-linux64-ix-058', 05:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:34 INFO - 'use_talos_json': True, 05:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:34 INFO - 'work_dir': 'build'} 05:54:34 INFO - [mozharness: 2017-07-30 12:54:34.129306Z] Running clobber step. 05:54:34 INFO - Running pre-action listener: _resource_record_pre_action 05:54:34 INFO - Running main action method: clobber 05:54:34 INFO - rmtree: /builds/slave/test/build 05:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:35 INFO - Running post-action listener: _resource_record_post_action 05:54:35 INFO - [mozharness: 2017-07-30 12:54:35.680329Z] Finished clobber step (success) 05:54:35 INFO - [mozharness: 2017-07-30 12:54:35.680430Z] Running read-buildbot-config step. 05:54:35 INFO - Running pre-action listener: _resource_record_pre_action 05:54:35 INFO - Running main action method: read_buildbot_config 05:54:35 INFO - Using buildbot properties: 05:54:35 INFO - { 05:54:35 INFO - "project": "", 05:54:35 INFO - "product": "firefox", 05:54:35 INFO - "who": "archaeopteryx@coole-files.de", 05:54:35 INFO - "installer_path": "public/build/target.tar.bz2", 05:54:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:54:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:54:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:54:35 INFO - "stage_platform": "linux64", 05:54:35 INFO - "basedir": "/builds/slave/test", 05:54:35 INFO - "buildnumber": 746, 05:54:35 INFO - "platform": "ubuntu64_hw", 05:54:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:54:35 INFO - "slavebuilddir": "test", 05:54:35 INFO - "taskId": "bbj_zwF0QyGeACcmvlXDkw", 05:54:35 INFO - "branch": "mozilla-central", 05:54:35 INFO - "script_repo_revision": "production", 05:54:35 INFO - "revision": "6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1", 05:54:35 INFO - "slavename": "talos-linux64-ix-058", 05:54:35 INFO - "repo_path": "mozilla-central" 05:54:35 INFO - } 05:54:35 INFO - Finding installer, test and symbols from parent task. 05:54:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bbj_zwF0QyGeACcmvlXDkw'}, attempt #1 05:54:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bbj_zwF0QyGeACcmvlXDkw'}, attempt #1 05:54:36 INFO - Task dependencies: B8fC0UWOT0Oorcf49xoIZw 05:54:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw'}, attempt #1 05:54:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:54:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json 05:54:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip 05:54:37 INFO - Running post-action listener: _resource_record_post_action 05:54:37 INFO - [mozharness: 2017-07-30 12:54:37.002840Z] Finished read-buildbot-config step (success) 05:54:37 INFO - [mozharness: 2017-07-30 12:54:37.003061Z] Running download-and-extract step. 05:54:37 INFO - Running pre-action listener: _resource_record_pre_action 05:54:37 INFO - Running main action method: download_and_extract 05:54:37 INFO - mkdir: /builds/slave/test/build/tests 05:54: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:54:37 INFO - trying https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json 05:54:37 INFO - Downloading https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:54:37 INFO - Downloaded 989 bytes. 05:54:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:54:37 INFO - Using the following test package requirements: 05:54:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:54:37 INFO - u'common': [u'target.common.tests.zip'], 05:54:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:54:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:54:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:54:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:54:37 INFO - u'mozbase': [u'target.common.tests.zip'], 05:54:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:54:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:54:37 INFO - u'web-platform': [u'target.common.tests.zip', 05:54:37 INFO - u'target.web-platform.tests.tar.gz'], 05:54:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:54:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:54:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip 05:54:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:54:37 INFO - Fetch https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip into memory 05:54:40 INFO - Content-Length response header: 72567071 05:54:40 INFO - Bytes received: 72567071 05:54:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:54:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip 05:54:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:54:51 INFO - Fetch https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.common.tests.zip into memory 05:54:53 INFO - Content-Length response header: 72567071 05:54:53 INFO - Bytes received: 72567071 05:55:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.talos.tests.zip 05:55:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:55:05 INFO - Fetch https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.talos.tests.zip into memory 05:55:07 INFO - Content-Length response header: 14496686 05:55:07 INFO - Bytes received: 14496686 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:07 INFO - trying https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:55:07 INFO - Downloading https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:55:10 INFO - Downloaded 62352183 bytes. 05:55:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:55:10 INFO - mkdir: /builds/slave/test/properties 05:55:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:10 INFO - Contents: 05:55:10 INFO - build_url:https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 05:55:10 INFO - Running post-action listener: _resource_record_post_action 05:55:10 INFO - Running post-action listener: set_extra_try_arguments 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.884532Z] Finished download-and-extract step (success) 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.884760Z] Running populate-webroot step. 05:55:10 INFO - Running pre-action listener: _resource_record_pre_action 05:55:10 INFO - Running main action method: populate_webroot 05:55:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'tests': ['damp', 'tps']}, 05:55:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:55:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:55:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:10 INFO - 'ts_paint', 05:55:10 INFO - 'tpaint', 05:55:10 INFO - 'sessionrestore', 05:55:10 INFO - 'sessionrestore_many_windows', 05:55:10 INFO - 'sessionrestore_no_auto_restore', 05:55:10 INFO - 'tabpaint']}, 05:55:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:55:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:55:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:55:10 INFO - 'talos_options': ['--mitmproxy', 05:55:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:55:10 INFO - '--firstNonBlankPaint'], 05:55:10 INFO - 'tests': ['quantum_pageload_google', 05:55:10 INFO - 'quantum_pageload_youtube', 05:55:10 INFO - 'quantum_pageload_amazon', 05:55:10 INFO - 'quantum_pageload_facebook']}, 05:55:10 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:55:10 INFO - 'talos_options': ['--stylo', 05:55:10 INFO - '--mitmproxy', 05:55:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:55:10 INFO - '--firstNonBlankPaint'], 05:55:10 INFO - 'tests': ['quantum_pageload_google', 05:55:10 INFO - 'quantum_pageload_youtube', 05:55:10 INFO - 'quantum_pageload_amazon', 05:55:10 INFO - 'quantum_pageload_facebook']}, 05:55:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:10 INFO - 'tsvgr_opacity', 05:55:10 INFO - 'tart', 05:55:10 INFO - 'tscrollx', 05:55:10 INFO - 'cart', 05:55:10 INFO - 'tsvg_static']}, 05:55:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:55:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:55:10 INFO - 'talos_options': ['--stylo', 05:55:10 INFO - '--stylo-threads=1', 05:55:10 INFO - '--mitmproxy', 05:55:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:55:10 INFO - '--firstNonBlankPaint'], 05:55:10 INFO - 'tests': ['tp6_google', 05:55:10 INFO - 'tp6_youtube', 05:55:10 INFO - 'tp6_amazon', 05:55:10 INFO - 'tp6_facebook']}, 05:55:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:55:10 INFO - 'talos_options': ['--xperf_path', 05:55:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:10 INFO - 'tests': ['tp5n']}}} 05:55:10 INFO - Running post-action listener: _resource_record_post_action 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.900179Z] Finished populate-webroot step (success) 05:55:10 INFO - [mozharness: 2017-07-30 12:55:10.900269Z] Running create-virtualenv step. 05:55:10 INFO - Running pre-action listener: _resource_record_pre_action 05:55:10 INFO - Running main action method: create_virtualenv 05:55:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:10 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:55:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:55:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:10 INFO - Using real prefix '/usr' 05:55:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:13 INFO - Installing pip.................done. 05:55:13 INFO - Return code: 0 05:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:55:13 INFO - Reading from file tmpfile_stdout 05:55:13 INFO - Output received: 05:55:13 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:55:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:55:13 INFO - Using env: {'DISPLAY': ':0', 05:55:13 INFO - 'HOME': '/home/cltbld', 05:55:13 INFO - 'LANG': 'en_US.UTF-8', 05:55:13 INFO - 'LANGUAGE': 'en_US:en', 05:55:13 INFO - 'LOGNAME': 'cltbld', 05:55:13 INFO - 'MAIL': '/var/mail/cltbld', 05:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:13 INFO - 'MOZ_NO_REMOTE': '1', 05:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:13 INFO - 'NO_EM_RESTART': '1', 05:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:13 INFO - 'PWD': '/builds/slave/test', 05:55:13 INFO - 'SHELL': '/bin/bash', 05:55:13 INFO - 'SHLVL': '1', 05:55:13 INFO - 'TERM': 'linux', 05:55:13 INFO - 'TMOUT': '86400', 05:55:13 INFO - 'USER': 'cltbld', 05:55:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:13 INFO - '_': '/tools/buildbot/bin/python'} 05:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:13 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:55:13 INFO - Cleaning up... 05:55:13 INFO - Return code: 0 05:55:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:55:13 INFO - Using env: {'DISPLAY': ':0', 05:55:13 INFO - 'HOME': '/home/cltbld', 05:55:13 INFO - 'LANG': 'en_US.UTF-8', 05:55:13 INFO - 'LANGUAGE': 'en_US:en', 05:55:13 INFO - 'LOGNAME': 'cltbld', 05:55:13 INFO - 'MAIL': '/var/mail/cltbld', 05:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:13 INFO - 'MOZ_NO_REMOTE': '1', 05:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:13 INFO - 'NO_EM_RESTART': '1', 05:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:13 INFO - 'PWD': '/builds/slave/test', 05:55:13 INFO - 'SHELL': '/bin/bash', 05:55:13 INFO - 'SHLVL': '1', 05:55:13 INFO - 'TERM': 'linux', 05:55:13 INFO - 'TMOUT': '86400', 05:55:13 INFO - 'USER': 'cltbld', 05:55:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:13 INFO - '_': '/tools/buildbot/bin/python'} 05:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:14 INFO - Downloading/unpacking psutil>=3.1.1 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:15 INFO - Installing collected packages: psutil 05:55:15 INFO - Running setup.py install for psutil 05:55:15 INFO - building 'psutil._psutil_linux' extension 05:55:15 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:55:15 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:55:15 INFO - building 'psutil._psutil_posix' extension 05:55:15 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:55:15 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:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:15 INFO - Successfully installed psutil 05:55:15 INFO - Cleaning up... 05:55:15 INFO - Return code: 0 05:55:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:55:15 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:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:15 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:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:15 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:15 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:55:15 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:55:15 INFO - Using env: {'DISPLAY': ':0', 05:55:15 INFO - 'HOME': '/home/cltbld', 05:55:15 INFO - 'LANG': 'en_US.UTF-8', 05:55:15 INFO - 'LANGUAGE': 'en_US:en', 05:55:15 INFO - 'LOGNAME': 'cltbld', 05:55:15 INFO - 'MAIL': '/var/mail/cltbld', 05:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:15 INFO - 'MOZ_NO_REMOTE': '1', 05:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:15 INFO - 'NO_EM_RESTART': '1', 05:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:15 INFO - 'PWD': '/builds/slave/test', 05:55:15 INFO - 'SHELL': '/bin/bash', 05:55:15 INFO - 'SHLVL': '1', 05:55:15 INFO - 'TERM': 'linux', 05:55:15 INFO - 'TMOUT': '86400', 05:55:15 INFO - 'USER': 'cltbld', 05:55:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:15 INFO - '_': '/tools/buildbot/bin/python'} 05:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:55:17 INFO - Installing collected packages: mozsystemmonitor 05:55:17 INFO - Running setup.py install for mozsystemmonitor 05:55:17 INFO - Successfully installed mozsystemmonitor 05:55:17 INFO - Cleaning up... 05:55:17 INFO - Return code: 0 05:55:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:55:17 INFO - Using env: {'DISPLAY': ':0', 05:55:17 INFO - 'HOME': '/home/cltbld', 05:55:17 INFO - 'LANG': 'en_US.UTF-8', 05:55:17 INFO - 'LANGUAGE': 'en_US:en', 05:55:17 INFO - 'LOGNAME': 'cltbld', 05:55:17 INFO - 'MAIL': '/var/mail/cltbld', 05:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:17 INFO - 'MOZ_NO_REMOTE': '1', 05:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:17 INFO - 'NO_EM_RESTART': '1', 05:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:17 INFO - 'PWD': '/builds/slave/test', 05:55:17 INFO - 'SHELL': '/bin/bash', 05:55:17 INFO - 'SHLVL': '1', 05:55:17 INFO - 'TERM': 'linux', 05:55:17 INFO - 'TMOUT': '86400', 05:55:17 INFO - 'USER': 'cltbld', 05:55:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:17 INFO - '_': '/tools/buildbot/bin/python'} 05:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:17 INFO - Downloading/unpacking jsonschema==2.5.1 05:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:18 INFO - warning: no files found matching '*.txt' 05:55:18 INFO - no previously-included directories found matching 'build' 05:55:18 INFO - no previously-included directories found matching 'dist' 05:55:18 INFO - no previously-included directories found matching '.git*' 05:55:18 INFO - Installing collected packages: jsonschema, functools32 05:55:18 INFO - Running setup.py install for functools32 05:55:19 INFO - warning: no files found matching '*.txt' 05:55:19 INFO - no previously-included directories found matching 'build' 05:55:19 INFO - no previously-included directories found matching 'dist' 05:55:19 INFO - no previously-included directories found matching '.git*' 05:55:19 INFO - Successfully installed jsonschema functools32 05:55:19 INFO - Cleaning up... 05:55:19 INFO - Return code: 0 05:55:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:55:19 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:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:19 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:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:19 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:19 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:55:19 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:55:19 INFO - Using env: {'DISPLAY': ':0', 05:55:19 INFO - 'HOME': '/home/cltbld', 05:55:19 INFO - 'LANG': 'en_US.UTF-8', 05:55:19 INFO - 'LANGUAGE': 'en_US:en', 05:55:19 INFO - 'LOGNAME': 'cltbld', 05:55:19 INFO - 'MAIL': '/var/mail/cltbld', 05:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:19 INFO - 'MOZ_NO_REMOTE': '1', 05:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:19 INFO - 'NO_EM_RESTART': '1', 05:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:19 INFO - 'PWD': '/builds/slave/test', 05:55:19 INFO - 'SHELL': '/bin/bash', 05:55:19 INFO - 'SHLVL': '1', 05:55:19 INFO - 'TERM': 'linux', 05:55:19 INFO - 'TMOUT': '86400', 05:55:19 INFO - 'USER': 'cltbld', 05:55:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:19 INFO - '_': '/tools/buildbot/bin/python'} 05:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:55:19 INFO - Cleaning up... 05:55:19 INFO - Return code: 0 05:55:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55:19 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:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:19 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:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:19 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:19 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:55:19 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:55:19 INFO - Using env: {'DISPLAY': ':0', 05:55:19 INFO - 'HOME': '/home/cltbld', 05:55:19 INFO - 'LANG': 'en_US.UTF-8', 05:55:19 INFO - 'LANGUAGE': 'en_US:en', 05:55:19 INFO - 'LOGNAME': 'cltbld', 05:55:19 INFO - 'MAIL': '/var/mail/cltbld', 05:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:19 INFO - 'MOZ_NO_REMOTE': '1', 05:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:19 INFO - 'NO_EM_RESTART': '1', 05:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:19 INFO - 'PWD': '/builds/slave/test', 05:55:19 INFO - 'SHELL': '/bin/bash', 05:55:19 INFO - 'SHLVL': '1', 05:55:19 INFO - 'TERM': 'linux', 05:55:19 INFO - 'TMOUT': '86400', 05:55:19 INFO - 'USER': 'cltbld', 05:55:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:19 INFO - '_': '/tools/buildbot/bin/python'} 05:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:19 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55:20 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:55:20 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:55:20 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:55:20 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:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55:21 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:55:21 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:55:21 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:55:21 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:55:21 INFO - Downloading docopt-0.6.1.tar.gz 05:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:21 INFO - Running setup.py install for blobuploader 05:55:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:21 INFO - Running setup.py install for requests 05:55:21 INFO - Running setup.py install for docopt 05:55:21 INFO - Successfully installed blobuploader requests docopt 05:55:21 INFO - Cleaning up... 05:55:21 INFO - Return code: 0 05:55:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:21 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:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:21 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:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:21 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:21 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:55:21 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:55:21 INFO - Using env: {'DISPLAY': ':0', 05:55:21 INFO - 'HOME': '/home/cltbld', 05:55:21 INFO - 'LANG': 'en_US.UTF-8', 05:55:21 INFO - 'LANGUAGE': 'en_US:en', 05:55:21 INFO - 'LOGNAME': 'cltbld', 05:55:21 INFO - 'MAIL': '/var/mail/cltbld', 05:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:21 INFO - 'MOZ_NO_REMOTE': '1', 05:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:21 INFO - 'NO_EM_RESTART': '1', 05:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:21 INFO - 'PWD': '/builds/slave/test', 05:55:21 INFO - 'SHELL': '/bin/bash', 05:55:21 INFO - 'SHLVL': '1', 05:55:21 INFO - 'TERM': 'linux', 05:55:21 INFO - 'TMOUT': '86400', 05:55:21 INFO - 'USER': 'cltbld', 05:55:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:21 INFO - '_': '/tools/buildbot/bin/python'} 05:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:22 INFO - Running setup.py (path:/tmp/pip-MWcKBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:22 INFO - Running setup.py (path:/tmp/pip-ucCijl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:22 INFO - Running setup.py (path:/tmp/pip-KJF2tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:22 INFO - Running setup.py (path:/tmp/pip-6A8hs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:22 INFO - Running setup.py (path:/tmp/pip-5CNpIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:22 INFO - Running setup.py (path:/tmp/pip-YBACvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:22 INFO - Running setup.py (path:/tmp/pip-b5e4uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:22 INFO - Running setup.py (path:/tmp/pip-khFd8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:22 INFO - Running setup.py (path:/tmp/pip-P9el9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:22 INFO - Running setup.py (path:/tmp/pip-DuzmtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:22 INFO - Running setup.py (path:/tmp/pip-BXTx8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:22 INFO - Running setup.py (path:/tmp/pip-eRt1Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:22 INFO - Running setup.py (path:/tmp/pip-XgyLur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:22 INFO - Running setup.py (path:/tmp/pip-PnFJgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:23 INFO - Running setup.py (path:/tmp/pip-YqTqJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:23 INFO - Running setup.py (path:/tmp/pip-7hLQ1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:23 INFO - Running setup.py (path:/tmp/pip-Crfhyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:23 INFO - Running setup.py install for manifestparser 05:55:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozcrash 05:55:23 INFO - Running setup.py install for mozdebug 05:55:23 INFO - Running setup.py install for mozdevice 05:55:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozfile 05:55:23 INFO - Running setup.py install for mozhttpd 05:55:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozinfo 05:55:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:23 INFO - Running setup.py install for mozInstall 05:55:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for mozleak 05:55:24 INFO - Running setup.py install for mozlog 05:55:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for moznetwork 05:55:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for mozprocess 05:55:24 INFO - Running setup.py install for mozprofile 05:55:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for mozrunner 05:55:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:24 INFO - Running setup.py install for mozscreenshot 05:55:24 INFO - Running setup.py install for moztest 05:55:24 INFO - Running setup.py install for mozversion 05:55:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:25 INFO - Cleaning up... 05:55:25 INFO - Return code: 0 05:55:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:25 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:25 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:55:25 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:55:25 INFO - Using env: {'DISPLAY': ':0', 05:55:25 INFO - 'HOME': '/home/cltbld', 05:55:25 INFO - 'LANG': 'en_US.UTF-8', 05:55:25 INFO - 'LANGUAGE': 'en_US:en', 05:55:25 INFO - 'LOGNAME': 'cltbld', 05:55:25 INFO - 'MAIL': '/var/mail/cltbld', 05:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:25 INFO - 'MOZ_NO_REMOTE': '1', 05:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:25 INFO - 'NO_EM_RESTART': '1', 05:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:25 INFO - 'PWD': '/builds/slave/test', 05:55:25 INFO - 'SHELL': '/bin/bash', 05:55:25 INFO - 'SHLVL': '1', 05:55:25 INFO - 'TERM': 'linux', 05:55:25 INFO - 'TMOUT': '86400', 05:55:25 INFO - 'USER': 'cltbld', 05:55:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:25 INFO - '_': '/tools/buildbot/bin/python'} 05:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:25 INFO - Running setup.py (path:/tmp/pip-cjaMz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:25 INFO - Running setup.py (path:/tmp/pip-Xio447-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:25 INFO - Running setup.py (path:/tmp/pip-sxM0mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:25 INFO - Running setup.py (path:/tmp/pip-2IMtkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:25 INFO - Running setup.py (path:/tmp/pip-bvHAf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:25 INFO - Running setup.py (path:/tmp/pip-Z0HYeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:25 INFO - Running setup.py (path:/tmp/pip-EUopin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:25 INFO - Running setup.py (path:/tmp/pip-S6u4ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:25 INFO - Running setup.py (path:/tmp/pip-5hmTxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:25 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:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:25 INFO - Running setup.py (path:/tmp/pip-e2E8cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:25 INFO - Running setup.py (path:/tmp/pip-b77kZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:26 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:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:26 INFO - Running setup.py (path:/tmp/pip-uGUgys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:26 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:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:26 INFO - Running setup.py (path:/tmp/pip-DbXpd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:26 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:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:26 INFO - Running setup.py (path:/tmp/pip-7qxrqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:26 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:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:26 INFO - Running setup.py (path:/tmp/pip-uHcACk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:26 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:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:26 INFO - Running setup.py (path:/tmp/pip-bPcAjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:26 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:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:26 INFO - Running setup.py (path:/tmp/pip-7zXX6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:26 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:55:26 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:55:26 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:55:26 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:55:26 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:55:26 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:55:26 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:55:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:27 INFO - Downloading blessings-1.6.tar.gz 05:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:27 INFO - Installing collected packages: blessings 05:55:27 INFO - Running setup.py install for blessings 05:55:27 INFO - Successfully installed blessings 05:55:27 INFO - Cleaning up... 05:55:27 INFO - Return code: 0 05:55:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:28 INFO - Reading from file tmpfile_stdout 05:55:28 INFO - Current package versions: 05:55:28 INFO - argparse == 1.2.1 05:55:28 INFO - blessings == 1.6 05:55:28 INFO - blobuploader == 1.2.4 05:55:28 INFO - docopt == 0.6.1 05:55:28 INFO - functools32 == 3.2.3-2 05:55:28 INFO - jsonschema == 2.5.1 05:55:28 INFO - manifestparser == 1.1 05:55:28 INFO - mozInstall == 1.13 05:55:28 INFO - mozcrash == 1.0 05:55:28 INFO - mozdebug == 0.1 05:55:28 INFO - mozdevice == 0.51 05:55:28 INFO - mozfile == 1.2 05:55:28 INFO - mozhttpd == 0.7 05:55:28 INFO - mozinfo == 0.10 05:55:28 INFO - mozleak == 0.1 05:55:28 INFO - mozlog == 3.5 05:55:28 INFO - moznetwork == 0.27 05:55:28 INFO - mozprocess == 0.25 05:55:28 INFO - mozprofile == 0.28 05:55:28 INFO - mozrunner == 6.13 05:55:28 INFO - mozscreenshot == 0.1 05:55:28 INFO - mozsystemmonitor == 0.3 05:55:28 INFO - moztest == 0.8 05:55:28 INFO - mozversion == 1.4 05:55:28 INFO - psutil == 3.1.1 05:55:28 INFO - requests == 1.2.3 05:55:28 INFO - wsgiref == 0.1.2 05:55:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:28 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:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:28 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:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:28 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:28 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:55:28 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:55:28 INFO - Using env: {'DISPLAY': ':0', 05:55:28 INFO - 'HOME': '/home/cltbld', 05:55:28 INFO - 'LANG': 'en_US.UTF-8', 05:55:28 INFO - 'LANGUAGE': 'en_US:en', 05:55:28 INFO - 'LOGNAME': 'cltbld', 05:55:28 INFO - 'MAIL': '/var/mail/cltbld', 05:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:28 INFO - 'MOZ_NO_REMOTE': '1', 05:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:28 INFO - 'NO_EM_RESTART': '1', 05:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:28 INFO - 'PWD': '/builds/slave/test', 05:55:28 INFO - 'SHELL': '/bin/bash', 05:55:28 INFO - 'SHLVL': '1', 05:55:28 INFO - 'TERM': 'linux', 05:55:28 INFO - 'TMOUT': '86400', 05:55:28 INFO - 'USER': 'cltbld', 05:55:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:28 INFO - '_': '/tools/buildbot/bin/python'} 05:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:28 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:55:28 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:29 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:55:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:55:29 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:55:29 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:55:29 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:55:29 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:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:55:29 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:55:29 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:55:29 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:55:29 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:55:29 INFO - Installing collected packages: marionette-driver, simplejson 05:55:29 INFO - Running setup.py install for marionette-driver 05:55:29 INFO - Running setup.py install for simplejson 05:55:29 INFO - building 'simplejson._speedups' extension 05:55:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:55:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:55:30 INFO - Successfully installed marionette-driver simplejson 05:55:30 INFO - Cleaning up... 05:55:30 INFO - Return code: 0 05:55:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:30 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:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:30 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:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:30 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 0x21c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2394a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2537d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, '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': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', '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:55:30 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:55:30 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:55:30 INFO - Using env: {'DISPLAY': ':0', 05:55:30 INFO - 'HOME': '/home/cltbld', 05:55:30 INFO - 'LANG': 'en_US.UTF-8', 05:55:30 INFO - 'LANGUAGE': 'en_US:en', 05:55:30 INFO - 'LOGNAME': 'cltbld', 05:55:30 INFO - 'MAIL': '/var/mail/cltbld', 05:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:30 INFO - 'MOZ_NO_REMOTE': '1', 05:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:30 INFO - 'NO_EM_RESTART': '1', 05:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:30 INFO - 'PWD': '/builds/slave/test', 05:55:30 INFO - 'SHELL': '/bin/bash', 05:55:30 INFO - 'SHLVL': '1', 05:55:30 INFO - 'TERM': 'linux', 05:55:30 INFO - 'TMOUT': '86400', 05:55:30 INFO - 'USER': 'cltbld', 05:55:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:30 INFO - '_': '/tools/buildbot/bin/python'} 05:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:31 INFO - Cleaning up... 05:55:31 INFO - Return code: 0 05:55:31 INFO - Running post-action listener: _resource_record_post_action 05:55:31 INFO - Running post-action listener: _start_resource_monitoring 05:55:31 INFO - Starting resource monitoring. 05:55:31 INFO - [mozharness: 2017-07-30 12:55:31.088888Z] Finished create-virtualenv step (success) 05:55:31 INFO - [mozharness: 2017-07-30 12:55:31.089354Z] Running install step. 05:55:31 INFO - Running pre-action listener: _resource_record_pre_action 05:55:31 INFO - Running main action method: install 05:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:31 INFO - Reading from file tmpfile_stdout 05:55:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:31 INFO - Reading from file tmpfile_stdout 05:55:31 INFO - Output received: 05:55:31 INFO - Usage: mozinstall [options] installer 05:55:31 INFO - Options: 05:55:31 INFO - -h, --help show this help message and exit 05:55:31 INFO - -d DEST, --destination=DEST 05:55:31 INFO - Directory to install application into. [default: 05:55:31 INFO - "/builds/slave/test"] 05:55:31 INFO - --app=APP Application being installed. [default: firefox] 05:55:31 INFO - mkdir: /builds/slave/test/build/application 05:55:31 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:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:55:49 INFO - Reading from file tmpfile_stdout 05:55:49 INFO - Output received: 05:55:49 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:49 INFO - Running post-action listener: _resource_record_post_action 05:55:49 INFO - [mozharness: 2017-07-30 12:55:49.554273Z] Finished install step (success) 05:55:49 INFO - [mozharness: 2017-07-30 12:55:49.554528Z] Running setup-mitmproxy step. 05:55:49 INFO - Running pre-action listener: _resource_record_pre_action 05:55:49 INFO - Running main action method: setup_mitmproxy 05:55:49 INFO - Skipping: mitmproxy is not required 05:55:49 INFO - Running post-action listener: _resource_record_post_action 05:55:49 INFO - [mozharness: 2017-07-30 12:55:49.555703Z] Finished setup-mitmproxy step (success) 05:55:49 INFO - [mozharness: 2017-07-30 12:55:49.555930Z] Running run-tests step. 05:55:49 INFO - Running pre-action listener: _resource_record_pre_action 05:55:49 INFO - Running pre-action listener: _set_gcov_prefix 05:55:49 INFO - Running main action method: run_tests 05:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:49 INFO - Python 2.7.3 05:55:49 INFO - Return code: 0 05:55:49 INFO - grabbing minidump binary from tooltool 05:55: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:55:49 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 0x2534eb0>, '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 0x2535db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2536240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:49 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:55:49 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:55:49 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:55:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:49 INFO - Return code: 0 05:55:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:49 INFO - ENV: RUST_BACKTRACE is now 1 05:55:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:55:49 INFO - Using env: {'DISPLAY': ':0', 05:55:49 INFO - 'HOME': '/home/cltbld', 05:55:49 INFO - 'LANG': 'en_US.UTF-8', 05:55:49 INFO - 'LANGUAGE': 'en_US:en', 05:55:49 INFO - 'LOGNAME': 'cltbld', 05:55:49 INFO - 'MAIL': '/var/mail/cltbld', 05:55:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:49 INFO - 'MOZ_NO_REMOTE': '1', 05:55:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:49 INFO - 'NO_EM_RESTART': '1', 05:55:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:49 INFO - 'PWD': '/builds/slave/test', 05:55:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:49 INFO - 'RUST_BACKTRACE': '1', 05:55:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:55:49 INFO - 'SHELL': '/bin/bash', 05:55:49 INFO - 'SHLVL': '1', 05:55:49 INFO - 'TERM': 'linux', 05:55:49 INFO - 'TMOUT': '86400', 05:55:49 INFO - 'USER': 'cltbld', 05:55:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671', 05:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:49 INFO - '_': '/tools/buildbot/bin/python'} 05:55:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:55:49 INFO - mozversion application_buildid: 20170730120914 05:55:49 INFO - mozversion application_changeset: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 05:55:49 INFO - mozversion application_display_name: Nightly 05:55:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:49 INFO - mozversion application_name: Firefox 05:55:49 INFO - mozversion application_remotingname: firefox 05:55:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:49 INFO - mozversion application_vendor: Mozilla 05:55:49 INFO - mozversion application_version: 56.0a1 05:55:49 INFO - mozversion platform_buildid: 20170730120914 05:55:49 INFO - mozversion platform_changeset: 6d1b50a370b4adffbb1ee73b9f51707c90d6a2b1 05:55:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:49 INFO - mozversion platform_version: 56.0a1 05:55:49 INFO - using testdate: 1501419349 05:55:49 INFO - actual date: 1501419349 05:55:49 INFO - starting webserver on 'localhost:40361' 05:55:49 INFO - SUITE-START | Running 2 tests 05:55:49 INFO - TEST-START | dromaeo_css 05:55:49 INFO - Initialising browser for dromaeo_css test... 05:55:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40361/getInfo.html -profile /tmp/tmp50FY6V/profile 05:55:49 INFO - TEST-INFO | started process 30207 (/builds/slave/test/build/application/firefox/firefox http://localhost:40361/getInfo.html) 05:55:55 INFO - TEST-INFO | 30207: exit 0 05:55:56 INFO - Browser initialized. 05:55:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:56 INFO - TEST-INFO | started process 30416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp50FY6V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:57 INFO - PID 30416 | 05:55:57 INFO - PID 30416 | (/builds/slave/test/build/application/firefox/firefox:30464): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:55:57 INFO - PID 30416 | 05:56:07 INFO - PID 30416 | RSS: Main: 171302912 05:56:07 INFO - PID 30416 | 05:59:06 INFO - PID 30416 | Cycle 1(1): loaded http://localhost:40361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40361/tests/dromaeo/cssquery-ext.html) 05:59:07 INFO - PID 30416 | RSS: Main: 173780992 05:59:07 INFO - PID 30416 | 06:02:09 INFO - PID 30416 | Cycle 1(1): loaded http://localhost:40361/tests/dromaeo/cssquery-ext.html (next: http://localhost:40361/tests/dromaeo/cssquery-jquery.html) 06:02:10 INFO - PID 30416 | RSS: Main: 171184128 06:02:10 INFO - PID 30416 | 06:05:12 INFO - PID 30416 | Cycle 1(1): loaded http://localhost:40361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40361/tests/dromaeo/cssquery-mootools.html) 06:05:12 INFO - PID 30416 | RSS: Main: 171159552 06:05:12 INFO - PID 30416 | 06:08:14 INFO - PID 30416 | Cycle 1(1): loaded http://localhost:40361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40361/tests/dromaeo/cssquery-prototype.html) 06:08:15 INFO - PID 30416 | RSS: Main: 171274240 06:08:15 INFO - PID 30416 | 06:11:19 INFO - PID 30416 | Cycle 1(1): loaded http://localhost:40361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40361/tests/dromaeo/cssquery-yui.html) 06:11:19 INFO - PID 30416 | RSS: Main: 174419968 06:11:19 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | Cycle 1(1): loaded http://localhost:40361/tests/dromaeo/cssquery-yui.html (next: http://localhost:40361/tests/dromaeo/cssquery-dojo.html) 06:14:21 INFO - PID 30416 | RSS: Main: 175628288 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | __start_tp_report 06:14:21 INFO - PID 30416 | _x_x_mozilla_page_load 06:14:21 INFO - PID 30416 | _x_x_mozilla_page_load_details 06:14:21 INFO - PID 30416 | |i|pagename|runs| 06:14:21 INFO - PID 30416 | |0;dojo.html;3119.984400078001;3131.4989601663724;3132.5927629408166;3146.43364194445;3170.0965224910906;6157.076438534222;6207.5033997280225;6255.343188965156;6281.591696539727;6334.429901308881;5967.910481342783;6129.448349648531;6131;6144.84637884052;6162.044883043124;5625.578081643883;5639.774409023634;5659.320881494205;5672.06410942194;5774.307083150028;5671.63134396265;5688.402717714643;5704.942950570504;5713.171590119451;5804.767809287645;5559.527440167591;5619.044762390383;5708.942910570903;5793.449622285876;5800.129980502916;5618.634788738719;5634.239377684001;5636.210930469738;5701.515371193454;5741.62679425836;5610.046292130307;5647.689377084259;5696.3733989261145;5704.971475142598;5728.770849166029;6006.909896351558;6062.545309101835;6100.969495152496;6129.938700612981;6236.03341482071;6513.739450421977;6543.1821022372205;6576.375244351779;6579.506537009744;6593.967030164818;6624.27133015368;6650.833729156761;6651.16860392451;6661.100751398548;6681.198256209237;6169.5064394848305;6176.81469555914;6177.567570270083;6186.969065154691;6221.129041934133;6704.430123439464;6791.456683465311;6794.626295553792;6798.728050878009;6838.14523184602;6472.838179045561;6483.61098334092;6488.416042556192;6549.345065493412;6572.80281591553;6604.8348791280605;6616.569922954993;6621.073049773036;6623.768168114093;6647.169103862017;6496.220453545605;6511.218653761484;6532.281449040602;6603.405693487609;6642.701078451481;6485.9946708260295;6548.607083575001;6581.769638062645;6584.176977877765;6673.4661227101715;5314.229436731653;5365.865853353697;5366.731663416814;5374;5393.7033463159905;4608.446986361658;4611.584957353854;4616;4648.837290694877;4651.953480465219;5676.602637815313;5697.914531282034;5768.826935191951;5776.1624564437925;5788.88422231553;6570.967145164243;6677.3656502632175;6697.6986035628515;6704.731810727516;6772.0857684212;5713.114467257582;5727.455891690282;5727.971360143172;5730.312362516442;5732.426757324234;5843.912341314884;5879.794207202813;5881.382454842265;5893.44012318829;5912.586118971631;6388.648624325614;6390.968045159838;6498.902516462257;6501.674916254168;6503.382178693017;6545.901811472737;6624.138861947916;6631.900521492085;6672.199336079701;6733.898991515229;6422.293547709654;6435.420812126931;6437.678116094083;6447.903281450688;6454.225492940877;6473.385028422293;6541.443977261986;6547.803565893031;6567.113439685581;6615.5038372123245;6765.323467653196;6787.966060169668;6789.2871248518195;6794.116764820542;6803.693833777393;6534.411902928759;6543.5419520633095;6544.509161812978;6549.901751473636;6565.146530950946;6347.96826015867;6438.873197190566;6450.677466126769;6480;6550.967245163743;6374.235091789015;6396.360363963567;6408.807735767934;6415.518836087405;6419.935800641933;6423.164988551458;6461.289258181502;6484.578502397329;6504.414602685781;6508.186476690414;6295.716692748929;6322.525810564318;6324.747010119728;6341.524385671001;6466.579672321473 06:14:21 INFO - PID 30416 | |1;ext.html;791.8574656561816;856.0284077571955;886.6320477002045;1140.4126874659546;1172.630621354274;30260.84869575652;40218.59781402185;41199.17601647965;41239.793801031024;41248.58751412485;41436.37845432321;41822;41920.790396048054;41951.16097678045;41964.531241406556;7455.366293865028;7577.16651168371;7634.427417943649;7634.427417943649;7642.159362470152;7483.62581870907;7591.5065520741255;7595.620218989028;7596.734114306;7596.962015189944;7563.848723025536;7584.772456826304;7621;7623.390128789683;7627.694892204333;7527.887081693779;7584.62076896153;7592.772216833504;7597.430192735567;7597.620118994056;7498.587577683225;7542.396608271325;7547.396208303323;7566.772996810105;7576.848463030764;37706;37860.81069594635;37876.24247515062;37961;38050.42924356137;3436.4501679731125;3449.534312867756;3483.6342184070813;3484.73864460164;3487.075924879909;29613.85193074021;29692.257693557618;29716.10851674453;29875.253118672208;29924.8503757482;4702.976485117587;4745.264484004984;4805.207140821795;4831.275308703723;4858.052679727454;178658;180303;180402;180439;180603;46747.532524675;46771.298430523566;46940.5305946943;47016.5298347019;47092.7645361771;53536.46463535393;54342.7282863591;54734;54746.17880731792;54834.17748733772;14388.712225755635;16717.331306747838;16861.747073793904;16880.240389182516;16974.745378819327;11861.940690296493;13764;13950.930245348709;14049.508267210598;14058.648533786738;14212.573622791333;14237.430502779773;14279.785803212751;14318.284085795669;14386.35261413239;5776.191333213354;5805.10020946754;5822;5950.285965684059;5959.433853783884;967.1005964453126;968.1772840182351;974.541965276319;1018.1651046142092;1020.739711373595;22461.55076898453;22548.0980760771;28681.426371472455;29373.412531749247;29462.852685736434;1047.738065483629;1058.4707646176912;1073.5276478349501;1076.311160857052;1083.8482612434266;11763.470643821049;15818.446354377542;15990.040597563951;16092.597685057966;16104.919475402548;234092.6362945463;234288;235664;235922;236796;54422.45577544253;55621.16568251399;55837.72081139568;55877;55891.44108558944;1449.14500444736;1466.3767898643248;1479.142097583399;1481.7481028225227;1482.3181336585076;26036.8698156508;27271.590926135726;27711.30721731973;27797.583036254877;27810.16569502918;37143.814280928425;37409.5036198549;37666;37694.62305377021;37708.926009068666;203121;204295;204438;204663;205918;33388.66611333856;35299.82350088336;36093.819530902176;36293.81853090718;36490.45264320984;44076.33885491784;45095;45492;45842.541574583825;46048;31956;32476.350472990882;32570.83714581412;32770.67229327676;33223.335533288715;31691.84154079215;31964.360712786078;32297;32297.51553726649;32715;36823.63176368202;37061;37133.628663714095;37213.069673257305;37258.813705931294;30174.396512070074;32540.83729581337;32766.50850237296;33009.83495082605;33725.3254934895;24401.755982439947;24626.87686561556;25316;25330.493390132462;25949.091781788302 06:14:21 INFO - PID 30416 | |2;jquery.html;544.5235419008368;547.8931608336376;548.4871645011914;552.8452033430641;562.9127485239787;20644;21451.034703438345;21475.67786483202;21586.676199856975;21646.89176554119;25450.74549254507;26069;26126.738732612666;26191.214263572077;26217.213483595522;6422.389872962084;6552.115464412314;6568.540202185849;6570.441512471446;6573.211214654249;6207.658578778165;6402.711877965503;6422.068800023993;6458.289588145324;6468.4825213983;6496.610203387788;6502.869942601169;6505.316941721122;6506.1216735740545;6506.902396464056;6464.676766161673;6472.805815825509;6477.287498375175;6486.4162225399705;6487.059376390421;5982.341942386334;5993.670348130851;6005.399460054004;6006.429389208019;6027.427394397525;25788;27626.309342266402;28367.290817729514;28382;28664.713352866413;1879.990600046991;1938.3603410874518;1939.0692467615484;1939.1273926733027;1939.1273926733027;18744.250229990783;19118.52203694905;19178;19179.712304315446;19193.808061919342;2282.6005449046515;2316.281952594701;2337.836351455399;2343.8593684378993;2405.398650337416;131059.34470327683;137811.31094344665;139891;140026;140284;13389.732205356033;14084.929575352262;14200.431982720576;14398.064125831788;14531.346089426;20134.69797953032;21038.684419733716;21120.78879211219;22243.777562224495;22264.332070037926;10435.721354244723;10495.790084198274;10585.259031867849;10611.09805666527;10816.810150883397;9977.80044399108;9998.600055997678;10078.748031299276;10131.493425328852;10154.543045562967;9039.728808135766;9200;9244.676436324697;9334.673286435078;9376.578053987587;2522.495500899827;2529.620556916477;2581.251437083225;2645.8544780036896;2728;913.7487191022522;933.9252859771202;938.474454305591;953.9332246742662;976.0873583199731;18013.27946882136;18438.07809609541;18834.623307533773;19183.424497265103;19385.224591016202;970.1656575345197;988.7528117970508;1019.9796004079877;1028.1517747858047;1036.9274150809522;9836.213102951746;10491.055804977435;13121.278329691768;13212.867871321163;13507.257100859548;518763;537936;539121;541988;547530;119167.40416298037;121105;122492;123314;125280.37359813324;1224.412282104577;1248.332142303863;1267;1280.8847203751707;1291.6835375333103;20079.39761807148;21234.893825530773;21666.6749998747;21961.67057494107;21997.120115195212;60076;61517.69241153944;63939.04091438725;65956.67021665053;66922;80134.19865801501;80778.59610701908;81124.18875811166;81489.59255203686;82085.58957205176;19695.803041969397;19851.106700198816;20241;20280;20293;22133.889330553244;22138.33584992453;22425.43936401603;22541.323760287218;22617.208397706003;15517.5344739658;15666.451674191349;15782.526524204291;16591;16748.330066797193;14818.25908704539;15728.134952577719;15989.680206395575;16010.519684409486;16104;16741.83258167403;18337;18448.907755461136;18479.70642055097;18502.44492665222;19259.22963081461;20551.561390702507;20831.791682082985;20984.160633574487;21016.36950891476;17898.10509474547;18453.985030823434;18627.72058419152;18640.627187456445;18739.812601873808 06:14:21 INFO - PID 30416 | |3;mootools.html;1306.3598836570081;1335.7662409078414;1337.9598612041643;1345.9394327255272;1360.9115407498514;13579.592612221637;13883.652908677288;14191.290435478224;14309.785353219697;14310.785338219936;14234.928825355884;14550.272486375692;14560.781588276184;14578.635534111627;14600.342984565694;2684.2349930269925;2719.714429984853;2720.782337413002;2724.087430710704;2726.1821453563853;2557.0922322575498;2671.8931242750364;2708.9458210835774;2714.050082471139;2716.1172618898836;2574.884130214145;2706.9593956090575;2707;2708.255229811798;2709.5258329792305;2691.3944362518473;2697.393086555529;2711.7288271172924;2737.411456536854;2738.0690565207824;2640.815142939995;2656.5351063563994;2672.545667236555;2681.7184195659565;2689.058829409691;13614.795778063337;13813.51652692151;13846.653833654138;13908.165510069428;13935.372908219155;7498.4001279897475;7742.651580678883;7774.922250777477;7784.494007889469;7812.921870781333;5040.571551418134;5052.191649336125;5175.663581867167;5261.579073674096;5270.39390470097;1684.292597109217;1689.7549855270918;1692.2976964559693;1715.5968347438343;1745.2320978769428;23023.884880575657;23267;23306.184283550163;23320.533589328286;23346.18288359899;6229.470495007885;6249.9062514062325;6279.686015699197;6331.778387756406;6367.395097465734;14378.209198494184;14509.92745036268;14572.344244509022;14606.926965365104;14656.267186640625;7318.670659820321;7488.625568721543;7500.774976750707;7517.285857843496;7521.172671006185;6587.209534855752;6949.791506254821;7069.010338552606;7079.469039822034;7119.92880071203;4824.421069471686;4998.700077995332;5017.272495488134;5021.171506701354;5044.092063428545;1339.8794108530278;1414.2151106135987;1423.459085547506;1424.1668623854953;1457.4825936792497;674.189514474805;750.7334896111911;756.1493320014984;776.3478677910582;784.2549577900903;6808.795736127924;7137.357637812622;7220.4584656151;7278.563286202845;7383;864.4121997042072;910.2717825739514;937.8499440089553;963.2631037256505;964.3731574476647;4141;4165.625093741578;4204.810783514749;4228.154369126126;4231.386448964883;17805.821941780418;18180.36368727088;18833.717494237597;18910.243590256236;18936.81063189378;18219.72670409945;18477.1685274163;18493;18524;18695.532611684815;10685.679429617125;10884.564617415215;10885.78228435411;10891.618793342195;10905.618303359503;7036.929630703832;7331.4134869209265;7468.734542147664;7501.774946751606;7530.736424225126;16442.588935276715;16728.749068763736;16935.91532042332;16959.830401695825;17387.174346693417;16390.590235244214;16622.667546648758;17147.828521714622;17230.396936107176;17357.392491262744;10926.890731092588;11247.606333778278;11294.774104518028;11306.095512358826;11307.830382544433;12577.119601627799;12577.43401546951;12806.423710933217;12983.870161298644;12996.09027368113;9896.45569493656;10084.445355505517;10507.106895913934;10540.789184216426;10600;9187.77030574241;9666.226701863694;9985.101340879066;10183;10246.692599222035;8194;8463.153684631488;8602.311815054905;8738.956305218433;8750.343724220837;5638.60529762929;5856.412235839109;5893.70531473416;6265.342139075331;6286.088517165077;6169.2288463942;6502.544821862424;6627.834304142435;6786.423154031962;6810.148731408574 06:14:21 INFO - PID 30416 | |4;prototype.html;470.1959649000207;480.25080873836816;503.5920904067703;506.7567567567568;508.9541941225289;6185.134081228632;6279.748810047598;6311.463525600318;6314.336994615563;6314.526410519206;5994.8801023979495;6032.517398608112;6036.8490787730325;6088.421599948009;6149.679173246442;4810.326554282403;4828.130936431449;4923.433805112404;4937.432195297551;4966.25506174075;4931.975340123295;4944.4313903900975;4953;4958.727270000149;4998.250262460624;4792.329073929653;4902.117618828609;4925.236588328797;4934.925976110361;4950.504949505039;4895.437024742147;4903.117438861003;4908.680935739166;4946.653734238605;4951.975240123812;4324.848630297956;4391.8682439526865;4437.800298986521;4438.977805110986;4442.334124703237;6080.847978800522;6098.756049758004;6129.264488261392;6158.259574489354;6168.414000669929;5694.857628559278;5735.483806457397;5735.971320143414;5752.942470575283;5760.395158508338;6534.673266336664;6561.147050883403;6571.188710547871;6574.93425065748;6622.582757293601;4845.806167753286;4866.416030076413;4867.221244600847;4887.926681099786;4892.363992680965;6911.2397636259975;6964.616946067914;6978.232394436608;7002.929970700278;7006.544574602634;4892.483330167659;4904.754762261944;4904.877378065506;4907.509249075064;4928.827491037797;4953.603711703127;4954.232094025432;4955.702657840541;4958.239824862194;4985.551300382983;5543.501084902378;5547.889042219133;5590.692511911802;5596.300462442195;5629.774809007676;6392.680365981682;6461.321561236096;6474.838129046717;6485.416312531895;6616.702248398834;1667.1247595012474;1686.3591835102582;1694.7542606322015;1729.4898005088278;1746.8951862888014;1179.9528018879148;1197.4970512384818;1201.2432167734446;1207.9879201207875;1212.8423304970474;5551;5616.079638587993;5622.493975542221;5638.126090455986;5659.207710920475;6478.514111441661;6540.345965403421;6564.770233041821;6590.670466476657;6599.934000660028;5601.943980560224;5685.459881311269;5735.512481439041;5742.483176514133;5743;3497.3529896969144;3531.823408829548;3559.2347645255877;3559.483874838134;3607.5851277102943;6497.545171837926;6501.707423165969;6505.251896031922;6553.901691474632;6618.602883826889;6837.897431538531;6875.831108711531;6904.275051119661;6933.341332573397;6952.791416257521;6433.356664333529;6462.095306657072;6496.252930912911;6506.642134682544;6532.771353002622;6666.666666666744;6731.85558455054;6756.223034351113;6761.208279805954;6763.86472270542;6573.375529324707;6631.750442283343;6713.1944166700305;6719.0178897226415;6741;6508.153939987771;6518.576292541159;6568.277489476058;6592.340765923369;6622.536422450382;4917.704937703749;4918.360613120271;4947.529984651453;4955.5044495550155;4956.851294461172;6709.664516774239;6788.86422271542;6789.1852977643;6811.93188068113;6841.076454678555;6412.39082287182;6429.38920802523;6537.70580323877;6548.246951600627;6557.131292537426;6549.967250163719;6552.6068435894;6559.6064236145985;6572.474202063728;6584.440322572635;6219.222597175353;6296.937030629635;6361.363863613787;6387.233531976192;6478.902816457663;6429.38920802523;6464.8707025858275;6464.967675161594;6531.967340163269;6540.83647908787;6250.1874756281395;6296.244450665949;6321.620702757849;6390.7763228286785;6406.295307516262 06:14:21 INFO - PID 30416 | |5;yui.html;882.8366752150848;901.6573701993243;917.6375331743957;917.7430319510537;919.3059240273592;16726.414575489845;17597.296108155675;17637.029963352026;17666.205020774065;21083.57832843342;19841.305554305603;21349;21378.786212137875;21513.354599362006;21543.6768448473;963.8602402651611;989.5794287427815;991.8710567626199;991.9752006199867;993.4734590666958;1006.3760468509535;1040.557762950743;1046.1787496815002;1048.1405247696891;1048.2086025051115;1080.9189310801682;1090.4765712458025;1095.4851219926622;1096.30932512517;1096.3915027159924;1075.9778210699867;1083.025277250473;1088.1729885287239;1088.455772113943;1089.1776708584969;798.5408390175672;803.5339503088195;805.7663277649475;805.8468890910708;807.1766797866144;17890.373836915645;18315.725264121047;18413.26346946134;18434.354797582153;19547.21811127553;19981.400557983285;20007.29974450902;20668.793312066988;20750.896245518827;20801.479963000893;14677.633059173499;14985.175815330153;15040.623984400368;15047.172405517693;15055.096694198382;3406.608240052376;3455.274392377604;3465.081753335368;3508.7193024557973;3526.647335266453;116401;121443.39278303552;125679;125793;128879;15350.385984560493;15532.844671553139;15619.219039048003;15700.68598628021;15783.447579334668;28531;28697.85651071773;28876;29448.11655650334;29851.253718657208;7308.488405811542;8511.702090426805;9076.636934522678;9083.318751093695;9150.954245228731;4315.482142142901;4384.868453946387;4406.889827754268;4415.139047885696;4416.227160247008;5045.394552653705;5203.037438073969;5827.562932780059;6006.5495087868585;6068.089786532056;1090.36758679967;1103.5420300575172;1124.3254047571393;1124.5389390349917;1128.430142777892;634.22307673101;635.0949896397707;644.1497223664811;647.9190101237346;666.6000399760202;10987.780244395228;11199.160062995308;11490.599418273398;11759.88240117605;11940.402979850973;635.4217661927623;660.9834754131089;671.3521451799037;684.2815044203567;688.1123350877413;5294.57643388528;5558.888822223533;6100.389961003864;6104.114903338991;6263.185785847902;96737.51631241798;97948.51025744969;98387;98957;100388.49805750925;84630.57684711537;85962.57018714867;89588.5520572393;90806.54596726975;93618.53190734003;70162.64918675374;71681;73554.63222683853;74044;75642.62178689182;11341.149413793833;12432.627021189379;12504.187227830162;12587.307698076327;12666.43001064936;34604.48093278653;34839.30321393609;35283.647163529065;35693.643063569034;36607.084822878576;61995;63822;65779.67110164418;66513.33486665071;67647.66176169088;18513.722294165327;18626.72059919075;18854.434366969013;18930.52673683169;18977.810221897606;20684.58630827345;20735.79264207399;21171.682424763334;21323.893380532998;21567.568648627253;18451.354202602844;18518.44444666662;19074.046297685338;19098.904505477385;19297.131629076444;17973.37093201732;18723.157457914152;18928.905355473136;18994.715079274098;19499.902500487406;17855.37506187277;18402.907985459988;18635.254589816257;19088.236470541022;19132.904335478233;12182.573609923611;12292.938535307267;12510.562130325396;12785.16896401731;12943.09398342107;13162.670933226364;13944.651383715489;14073.648158796112;14445.133292002514;14507.274636268356 06:14:21 INFO - PID 30416 | __end_tp_report 06:14:21 INFO - PID 30416 | __start_cc_report 06:14:21 INFO - PID 30416 | _x_x_mozilla_cycle_collect,361 06:14:21 INFO - PID 30416 | __end_cc_report 06:14:21 INFO - PID 30416 | __startTimestamp1501420461718__endTimestamp 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | ------- Summary: start ------- 06:14:21 INFO - PID 30416 | Number of tests: 6 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | [#0] dojo.html Cycles:165 Average:6109.65 Median:6390.97 stddev:715.37 (11.2%) stddev-sans-first:678.03 06:14:21 INFO - PID 30416 | Values: 3120.0 3131.5 3132.6 3146.4 3170.1 6157.1 6207.5 6255.3 6281.6 6334.4 5967.9 6129.4 6131.0 6144.8 6162.0 5625.6 5639.8 5659.3 5672.1 5774.3 5671.6 5688.4 5704.9 5713.2 5804.8 5559.5 5619.0 5708.9 5793.4 5800.1 5618.6 5634.2 5636.2 5701.5 5741.6 5610.0 5647.7 5696.4 5705.0 5728.8 6006.9 6062.5 6101.0 6129.9 6236.0 6513.7 6543.2 6576.4 6579.5 6594.0 6624.3 6650.8 6651.2 6661.1 6681.2 6169.5 6176.8 6177.6 6187.0 6221.1 6704.4 6791.5 6794.6 6798.7 6838.1 6472.8 6483.6 6488.4 6549.3 6572.8 6604.8 6616.6 6621.1 6623.8 6647.2 6496.2 6511.2 6532.3 6603.4 6642.7 6486.0 6548.6 6581.8 6584.2 6673.5 5314.2 5365.9 5366.7 5374.0 5393.7 4608.4 4611.6 4616.0 4648.8 4652.0 5676.6 5697.9 5768.8 5776.2 5788.9 6571.0 6677.4 6697.7 6704.7 6772.1 5713.1 5727.5 5728.0 5730.3 5732.4 5843.9 5879.8 5881.4 5893.4 5912.6 6388.6 6391.0 6498.9 6501.7 6503.4 6545.9 6624.1 6631.9 6672.2 6733.9 6422.3 6435.4 6437.7 6447.9 6454.2 6473.4 6541.4 6547.8 6567.1 6615.5 6765.3 6788.0 6789.3 6794.1 6803.7 6534.4 6543.5 6544.5 6549.9 6565.1 6348.0 6438.9 6450.7 6480.0 6551.0 6374.2 6396.4 6408.8 6415.5 6419.9 6423.2 6461.3 6484.6 6504.4 6508.2 6295.7 6322.5 6324.7 6341.5 6466.6 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | [#1] ext.html Cycles:180 Average:38127.84 Median:19393.45 stddev:53832.37 (277.6%) stddev-sans-first:53910.38 06:14:21 INFO - PID 30416 | Values: 791.9 856.0 886.6 1140.4 1172.6 30260.8 40218.6 41199.2 41239.8 41248.6 41436.4 41822.0 41920.8 41951.2 41964.5 7455.4 7577.2 7634.4 7634.4 7642.2 7483.6 7591.5 7595.6 7596.7 7597.0 7563.8 7584.8 7621.0 7623.4 7627.7 7527.9 7584.6 7592.8 7597.4 7597.6 7498.6 7542.4 7547.4 7566.8 7576.8 37706.0 37860.8 37876.2 37961.0 38050.4 3436.5 3449.5 3483.6 3484.7 3487.1 29613.9 29692.3 29716.1 29875.3 29924.9 4703.0 4745.3 4805.2 4831.3 4858.1 178658.0 180303.0 180402.0 180439.0 180603.0 46747.5 46771.3 46940.5 47016.5 47092.8 53536.5 54342.7 54734.0 54746.2 54834.2 14388.7 16717.3 16861.7 16880.2 16974.7 11861.9 13764.0 13950.9 14049.5 14058.6 14212.6 14237.4 14279.8 14318.3 14386.4 5776.2 5805.1 5822.0 5950.3 5959.4 967.1 968.2 974.5 1018.2 1020.7 22461.6 22548.1 28681.4 29373.4 29462.9 1047.7 1058.5 1073.5 1076.3 1083.8 11763.5 15818.4 15990.0 16092.6 16104.9 234092.6 234288.0 235664.0 235922.0 236796.0 54422.5 55621.2 55837.7 55877.0 55891.4 1449.1 1466.4 1479.1 1481.7 1482.3 26036.9 27271.6 27711.3 27797.6 27810.2 37143.8 37409.5 37666.0 37694.6 37708.9 203121.0 204295.0 204438.0 204663.0 205918.0 33388.7 35299.8 36093.8 36293.8 36490.5 44076.3 45095.0 45492.0 45842.5 46048.0 31956.0 32476.4 32570.8 32770.7 33223.3 31691.8 31964.4 32297.0 32297.5 32715.0 36823.6 37061.0 37133.6 37213.1 37258.8 30174.4 32540.8 32766.5 33009.8 33725.3 24401.8 24626.9 25316.0 25330.5 25949.1 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | [#2] jquery.html Cycles:180 Average:36878.65 Median:21814.17 stddev:90171.28 (413.4%) stddev-sans-first:90382.97 06:14:21 INFO - PID 30416 | Values: 544.5 547.9 548.5 552.8 562.9 20644.0 21451.0 21475.7 21586.7 21646.9 25450.7 26069.0 26126.7 26191.2 26217.2 6422.4 6552.1 6568.5 6570.4 6573.2 6207.7 6402.7 6422.1 6458.3 6468.5 6496.6 6502.9 6505.3 6506.1 6506.9 6464.7 6472.8 6477.3 6486.4 6487.1 5982.3 5993.7 6005.4 6006.4 6027.4 25788.0 27626.3 28367.3 28382.0 28664.7 1880.0 1938.4 1939.1 1939.1 1939.1 18744.3 19118.5 19178.0 19179.7 19193.8 2282.6 2316.3 2337.8 2343.9 2405.4 131059.3 137811.3 139891.0 140026.0 140284.0 13389.7 14084.9 14200.4 14398.1 14531.3 20134.7 21038.7 21120.8 22243.8 22264.3 10435.7 10495.8 10585.3 10611.1 10816.8 9977.8 9998.6 10078.7 10131.5 10154.5 9039.7 9200.0 9244.7 9334.7 9376.6 2522.5 2529.6 2581.3 2645.9 2728.0 913.7 933.9 938.5 953.9 976.1 18013.3 18438.1 18834.6 19183.4 19385.2 970.2 988.8 1020.0 1028.2 1036.9 9836.2 10491.1 13121.3 13212.9 13507.3 518763.0 537936.0 539121.0 541988.0 547530.0 119167.4 121105.0 122492.0 123314.0 125280.4 1224.4 1248.3 1267.0 1280.9 1291.7 20079.4 21234.9 21666.7 21961.7 21997.1 60076.0 61517.7 63939.0 65956.7 66922.0 80134.2 80778.6 81124.2 81489.6 82085.6 19695.8 19851.1 20241.0 20280.0 20293.0 22133.9 22138.3 22425.4 22541.3 22617.2 15517.5 15666.5 15782.5 16591.0 16748.3 14818.3 15728.1 15989.7 16010.5 16104.0 16741.8 18337.0 18448.9 18479.7 18502.4 19259.2 20551.6 20831.8 20984.2 21016.4 17898.1 18454.0 18627.7 18640.6 18739.8 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | [#3] mootools.html Cycles:180 Average:8447.03 Median:2694.39 stddev:5854.50 (217.3%) stddev-sans-first:5846.34 06:14:21 INFO - PID 30416 | Values: 1306.4 1335.8 1338.0 1345.9 1360.9 13579.6 13883.7 14191.3 14309.8 14310.8 14234.9 14550.3 14560.8 14578.6 14600.3 2684.2 2719.7 2720.8 2724.1 2726.2 2557.1 2671.9 2708.9 2714.1 2716.1 2574.9 2707.0 2707.0 2708.3 2709.5 2691.4 2697.4 2711.7 2737.4 2738.1 2640.8 2656.5 2672.5 2681.7 2689.1 13614.8 13813.5 13846.7 13908.2 13935.4 7498.4 7742.7 7774.9 7784.5 7812.9 5040.6 5052.2 5175.7 5261.6 5270.4 1684.3 1689.8 1692.3 1715.6 1745.2 23023.9 23267.0 23306.2 23320.5 23346.2 6229.5 6249.9 6279.7 6331.8 6367.4 14378.2 14509.9 14572.3 14606.9 14656.3 7318.7 7488.6 7500.8 7517.3 7521.2 6587.2 6949.8 7069.0 7079.5 7119.9 4824.4 4998.7 5017.3 5021.2 5044.1 1339.9 1414.2 1423.5 1424.2 1457.5 674.2 750.7 756.1 776.3 784.3 6808.8 7137.4 7220.5 7278.6 7383.0 864.4 910.3 937.8 963.3 964.4 4141.0 4165.6 4204.8 4228.2 4231.4 17805.8 18180.4 18833.7 18910.2 18936.8 18219.7 18477.2 18493.0 18524.0 18695.5 10685.7 10884.6 10885.8 10891.6 10905.6 7036.9 7331.4 7468.7 7501.8 7530.7 16442.6 16728.7 16935.9 16959.8 17387.2 16390.6 16622.7 17147.8 17230.4 17357.4 10926.9 11247.6 11294.8 11306.1 11307.8 12577.1 12577.4 12806.4 12983.9 12996.1 9896.5 10084.4 10507.1 10540.8 10600.0 9187.8 9666.2 9985.1 10183.0 10246.7 8194.0 8463.2 8602.3 8739.0 8750.3 5638.6 5856.4 5893.7 6265.3 6286.1 6169.2 6502.5 6627.8 6786.4 6810.1 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | [#4] prototype.html Cycles:180 Average:5480.97 Median:6114.01 stddev:1556.77 (25.5%) stddev-sans-first:1515.03 06:14:21 INFO - PID 30416 | Values: 470.2 480.3 503.6 506.8 509.0 6185.1 6279.7 6311.5 6314.3 6314.5 5994.9 6032.5 6036.8 6088.4 6149.7 4810.3 4828.1 4923.4 4937.4 4966.3 4932.0 4944.4 4953.0 4958.7 4998.3 4792.3 4902.1 4925.2 4934.9 4950.5 4895.4 4903.1 4908.7 4946.7 4952.0 4324.8 4391.9 4437.8 4439.0 4442.3 6080.8 6098.8 6129.3 6158.3 6168.4 5694.9 5735.5 5736.0 5752.9 5760.4 6534.7 6561.1 6571.2 6574.9 6622.6 4845.8 4866.4 4867.2 4887.9 4892.4 6911.2 6964.6 6978.2 7002.9 7006.5 4892.5 4904.8 4904.9 4907.5 4928.8 4953.6 4954.2 4955.7 4958.2 4985.6 5543.5 5547.9 5590.7 5596.3 5629.8 6392.7 6461.3 6474.8 6485.4 6616.7 1667.1 1686.4 1694.8 1729.5 1746.9 1180.0 1197.5 1201.2 1208.0 1212.8 5551.0 5616.1 5622.5 5638.1 5659.2 6478.5 6540.3 6564.8 6590.7 6599.9 5601.9 5685.5 5735.5 5742.5 5743.0 3497.4 3531.8 3559.2 3559.5 3607.6 6497.5 6501.7 6505.3 6553.9 6618.6 6837.9 6875.8 6904.3 6933.3 6952.8 6433.4 6462.1 6496.3 6506.6 6532.8 6666.7 6731.9 6756.2 6761.2 6763.9 6573.4 6631.8 6713.2 6719.0 6741.0 6508.2 6518.6 6568.3 6592.3 6622.5 4917.7 4918.4 4947.5 4955.5 4956.9 6709.7 6788.9 6789.2 6811.9 6841.1 6412.4 6429.4 6537.7 6548.2 6557.1 6550.0 6552.6 6559.6 6572.5 6584.4 6219.2 6296.9 6361.4 6387.2 6478.9 6429.4 6464.9 6465.0 6532.0 6540.8 6250.2 6296.2 6321.6 6390.8 6406.3 06:14:21 INFO - PID 30416 | 06:14:21 INFO - PID 30416 | [#5] yui.html Cycles:180 Average:22371.45 Median:20743.34 stddev:29555.12 (142.5%) stddev-sans-first:29593.98 06:14:21 INFO - PID 30416 | Values: 882.8 901.7 917.6 917.7 919.3 16726.4 17597.3 17637.0 17666.2 21083.6 19841.3 21349.0 21378.8 21513.4 21543.7 963.9 989.6 991.9 992.0 993.5 1006.4 1040.6 1046.2 1048.1 1048.2 1080.9 1090.5 1095.5 1096.3 1096.4 1076.0 1083.0 1088.2 1088.5 1089.2 798.5 803.5 805.8 805.8 807.2 17890.4 18315.7 18413.3 18434.4 19547.2 19981.4 20007.3 20668.8 20750.9 20801.5 14677.6 14985.2 15040.6 15047.2 15055.1 3406.6 3455.3 3465.1 3508.7 3526.6 116401.0 121443.4 125679.0 125793.0 128879.0 15350.4 15532.8 15619.2 15700.7 15783.4 28531.0 28697.9 28876.0 29448.1 29851.3 7308.5 8511.7 9076.6 9083.3 9151.0 4315.5 4384.9 4406.9 4415.1 4416.2 5045.4 5203.0 5827.6 6006.5 6068.1 1090.4 1103.5 1124.3 1124.5 1128.4 634.2 635.1 644.1 647.9 666.6 10987.8 11199.2 11490.6 11759.9 11940.4 635.4 661.0 671.4 684.3 688.1 5294.6 5558.9 6100.4 6104.1 6263.2 96737.5 97948.5 98387.0 98957.0 100388.5 84630.6 85962.6 89588.6 90806.5 93618.5 70162.6 71681.0 73554.6 74044.0 75642.6 11341.1 12432.6 12504.2 12587.3 12666.4 34604.5 34839.3 35283.6 35693.6 36607.1 61995.0 63822.0 65779.7 66513.3 67647.7 18513.7 18626.7 18854.4 18930.5 18977.8 20684.6 20735.8 21171.7 21323.9 21567.6 18451.4 18518.4 19074.0 19098.9 19297.1 17973.4 18723.2 18928.9 18994.7 19499.9 17855.4 18402.9 18635.3 19088.2 19132.9 12182.6 12292.9 12510.6 12785.2 12943.1 13162.7 13944.7 14073.6 14445.1 14507.3 06:14:21 INFO - PID 30416 | -------- Summary: end -------- 06:14:21 INFO - PID 30416 | 06:14:22 INFO - TEST-INFO | 30416: exit 0 06:14:22 INFO - TEST-OK | dromaeo_css | took 1112555ms 06:14:22 INFO - TEST-START | kraken 06:14:22 INFO - Initialising browser for kraken test... 06:14:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40361/getInfo.html -profile /tmp/tmpjMwogN/profile 06:14:22 INFO - TEST-INFO | started process 30777 (/builds/slave/test/build/application/firefox/firefox http://localhost:40361/getInfo.html) 06:14:28 INFO - TEST-INFO | 30777: exit 0 06:14:28 INFO - Browser initialized. 06:14:28 INFO - Running cycle 1/1 for kraken test... 06:14:28 INFO - TEST-INFO | started process 30982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjMwogN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:29 INFO - PID 30982 | 06:14:29 INFO - PID 30982 | (/builds/slave/test/build/application/firefox/firefox:31030): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:14:29 INFO - PID 30982 | 06:14:39 INFO - PID 30982 | RSS: Main: 171483136 06:14:39 INFO - PID 30982 | 06:14:42 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40361/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:43 INFO - PID 30982 | RSS: Main: 177565696 06:14:43 INFO - PID 30982 | 06:14:45 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40361/tests/kraken/driver.html?testName=audio-dft) 06:14:46 INFO - PID 30982 | RSS: Main: 178098176 06:14:46 INFO - PID 30982 | 06:14:49 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40361/tests/kraken/driver.html?testName=audio-fft) 06:14:50 INFO - PID 30982 | RSS: Main: 171401216 06:14:50 INFO - PID 30982 | 06:14:52 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40361/tests/kraken/driver.html?testName=audio-oscillator) 06:14:52 INFO - PID 30982 | RSS: Main: 172081152 06:14:52 INFO - PID 30982 | 06:14:54 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:55 INFO - PID 30982 | RSS: Main: 172179456 06:14:55 INFO - PID 30982 | 06:14:58 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40361/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:59 INFO - PID 30982 | RSS: Main: 174538752 06:14:59 INFO - PID 30982 | 06:15:02 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40361/tests/kraken/driver.html?testName=imaging-desaturate) 06:15:03 INFO - PID 30982 | RSS: Main: 174624768 06:15:03 INFO - PID 30982 | 06:15:06 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40361/tests/kraken/driver.html?testName=json-parse-financial) 06:15:06 INFO - PID 30982 | RSS: Main: 175112192 06:15:06 INFO - PID 30982 | 06:15:08 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:09 INFO - PID 30982 | RSS: Main: 175316992 06:15:09 INFO - PID 30982 | 06:15:10 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:11 INFO - PID 30982 | RSS: Main: 172400640 06:15:11 INFO - PID 30982 | 06:15:13 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:14 INFO - PID 30982 | RSS: Main: 172400640 06:15:14 INFO - PID 30982 | 06:15:17 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:17 INFO - PID 30982 | RSS: Main: 172974080 06:15:17 INFO - PID 30982 | 06:15:20 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:21 INFO - PID 30982 | RSS: Main: 173121536 06:15:21 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | Cycle 1(1): loaded http://localhost:40361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40361/tests/kraken/driver.html?testName=ai-astar) 06:15:23 INFO - PID 30982 | RSS: Main: 174399488 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | __start_tp_report 06:15:23 INFO - PID 30982 | _x_x_mozilla_page_load 06:15:23 INFO - PID 30982 | _x_x_mozilla_page_load_details 06:15:23 INFO - PID 30982 | |i|pagename|runs| 06:15:23 INFO - PID 30982 | |0;ai-astar;99;109;102;109;110;116;110;101;107;110 06:15:23 INFO - PID 30982 | |1;audio-beat-detection;176;126;146;180;119;142;144;122;175;122 06:15:23 INFO - PID 30982 | |2;audio-dft;167;168;168;163;166;163;169;173;164;163 06:15:23 INFO - PID 30982 | |3;audio-fft;75;76;77;172;86;77;75;87;94;75 06:15:23 INFO - PID 30982 | |4;audio-oscillator;78;79;132;79;77;78;125;78;79;125 06:15:23 INFO - PID 30982 | |5;imaging-gaussian-blur;114;114;115;115;115;115;115;115;114;122 06:15:23 INFO - PID 30982 | |6;imaging-darkroom;152;152;152;153;153;152;152;151;152;150 06:15:23 INFO - PID 30982 | |7;imaging-desaturate;94;94;94;95;94;94;94;94;94;95 06:15:23 INFO - PID 30982 | |8;json-parse-financial;56;56;57;57;57;57;55;55;55;63 06:15:23 INFO - PID 30982 | |9;json-stringify-tinderbox;55;54;56;54;54;54;54;55;54;54 06:15:23 INFO - PID 30982 | |10;stanford-crypto-aes;80;80;86;82;80;83;80;93;91;80 06:15:23 INFO - PID 30982 | |11;stanford-crypto-ccm;143;131;136;131;133;132;129;133;143;172 06:15:23 INFO - PID 30982 | |12;stanford-crypto-pbkdf2;192;180;177;192;181;183;181;178;182;181 06:15:23 INFO - PID 30982 | |13;stanford-crypto-sha256-iterative;69;68;68;69;67;67;67;67;67;66 06:15:23 INFO - PID 30982 | __end_tp_report 06:15:23 INFO - PID 30982 | __start_cc_report 06:15:23 INFO - PID 30982 | _x_x_mozilla_cycle_collect,982 06:15:23 INFO - PID 30982 | __end_cc_report 06:15:23 INFO - PID 30982 | __startTimestamp1501420523582__endTimestamp 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | ------- Summary: start ------- 06:15:23 INFO - PID 30982 | Number of tests: 14 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#0] ai-astar Cycles:10 Average:107.30 Median:110.00 stddev:5.17 (4.7%) stddev-sans-first:4.52 06:15:23 INFO - PID 30982 | Values: 99.0 109.0 102.0 109.0 110.0 116.0 110.0 101.0 107.0 110.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:145.00 stddev:24.02 (16.6%) stddev-sans-first:22.74 06:15:23 INFO - PID 30982 | Values: 176.0 126.0 146.0 180.0 119.0 142.0 144.0 122.0 175.0 122.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.50 stddev:3.27 (2.0%) stddev-sans-first:3.46 06:15:23 INFO - PID 30982 | Values: 167.0 168.0 168.0 163.0 166.0 163.0 169.0 173.0 164.0 163.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#3] audio-fft Cycles:10 Average:89.40 Median:77.00 stddev:29.76 (38.6%) stddev-sans-first:31.10 06:15:23 INFO - PID 30982 | Values: 75.0 76.0 77.0 172.0 86.0 77.0 75.0 87.0 94.0 75.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:23.78 (30.5%) stddev-sans-first:24.59 06:15:23 INFO - PID 30982 | Values: 78.0 79.0 132.0 79.0 77.0 78.0 125.0 78.0 79.0 125.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:2.37 (2.1%) stddev-sans-first:2.46 06:15:23 INFO - PID 30982 | Values: 114.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 122.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 06:15:23 INFO - PID 30982 | Values: 152.0 152.0 152.0 153.0 153.0 152.0 152.0 151.0 152.0 150.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:15:23 INFO - PID 30982 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:2.35 (4.1%) stddev-sans-first:2.47 06:15:23 INFO - PID 30982 | Values: 56.0 56.0 57.0 57.0 57.0 57.0 55.0 55.0 55.0 63.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 06:15:23 INFO - PID 30982 | Values: 55.0 54.0 56.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:4.90 (5.9%) stddev-sans-first:5.04 06:15:23 INFO - PID 30982 | Values: 80.0 80.0 86.0 82.0 80.0 83.0 80.0 93.0 91.0 80.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.50 stddev:12.80 (9.5%) stddev-sans-first:13.46 06:15:23 INFO - PID 30982 | Values: 143.0 131.0 136.0 131.0 133.0 132.0 129.0 133.0 143.0 172.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:181.50 stddev:5.21 (2.9%) stddev-sans-first:4.30 06:15:23 INFO - PID 30982 | Values: 192.0 180.0 177.0 192.0 181.0 183.0 181.0 178.0 182.0 181.0 06:15:23 INFO - PID 30982 | 06:15:23 INFO - PID 30982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 06:15:23 INFO - PID 30982 | Values: 69.0 68.0 68.0 69.0 67.0 67.0 67.0 67.0 67.0 66.0 06:15:23 INFO - PID 30982 | -------- Summary: end -------- 06:15:23 INFO - PID 30982 | 06:15:24 INFO - PID 30982 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:15:24 INFO - TEST-INFO | 30982: exit 0 06:15:24 INFO - TEST-OK | kraken | took 61914ms 06:15:24 INFO - SUITE-END | took 1174s 06:15:24 INFO - Completed test suite (00:19:34) 06:15:24 INFO - javascript benchmark 06:15:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8424.448625585917, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.984400078001, 3131.4989601663724, 3132.5927629408166, 3146.43364194445, 3170.0965224910906, 6157.076438534222, 6207.5033997280225, 6255.343188965156, 6281.591696539727, 6334.429901308881, 5967.910481342783, 6129.448349648531, 6131.0, 6144.84637884052, 6162.044883043124, 5625.578081643883, 5639.774409023634, 5659.320881494205, 5672.06410942194, 5774.307083150028, 5671.63134396265, 5688.402717714643, 5704.942950570504, 5713.171590119451, 5804.767809287645, 5559.527440167591, 5619.044762390383, 5708.942910570903, 5793.449622285876, 5800.129980502916, 5618.634788738719, 5634.239377684001, 5636.210930469738, 5701.515371193454, 5741.62679425836, 5610.046292130307, 5647.689377084259, 5696.3733989261145, 5704.971475142598, 5728.770849166029, 6006.909896351558, 6062.545309101835, 6100.969495152496, 6129.938700612981, 6236.03341482071, 6513.739450421977, 6543.1821022372205, 6576.375244351779, 6579.506537009744, 6593.967030164818, 6624.27133015368, 6650.833729156761, 6651.16860392451, 6661.100751398548, 6681.198256209237, 6169.5064394848305, 6176.81469555914, 6177.567570270083, 6186.969065154691, 6221.129041934133, 6704.430123439464, 6791.456683465311, 6794.626295553792, 6798.728050878009, 6838.14523184602, 6472.838179045561, 6483.61098334092, 6488.416042556192, 6549.345065493412, 6572.80281591553, 6604.8348791280605, 6616.569922954993, 6621.073049773036, 6623.768168114093, 6647.169103862017, 6496.220453545605, 6511.218653761484, 6532.281449040602, 6603.405693487609, 6642.701078451481, 6485.9946708260295, 6548.607083575001, 6581.769638062645, 6584.176977877765, 6673.4661227101715, 5314.229436731653, 5365.865853353697, 5366.731663416814, 5374.0, 5393.7033463159905, 4608.446986361658, 4611.584957353854, 4616.0, 4648.837290694877, 4651.953480465219, 5676.602637815313, 5697.914531282034, 5768.826935191951, 5776.1624564437925, 5788.88422231553, 6570.967145164243, 6677.3656502632175, 6697.6986035628515, 6704.731810727516, 6772.0857684212, 5713.114467257582, 5727.455891690282, 5727.971360143172, 5730.312362516442, 5732.426757324234, 5843.912341314884, 5879.794207202813, 5881.382454842265, 5893.44012318829, 5912.586118971631, 6388.648624325614, 6390.968045159838, 6498.902516462257, 6501.674916254168, 6503.382178693017, 6545.901811472737, 6624.138861947916, 6631.900521492085, 6672.199336079701, 6733.898991515229, 6422.293547709654, 6435.420812126931, 6437.678116094083, 6447.903281450688, 6454.225492940877, 6473.385028422293, 6541.443977261986, 6547.803565893031, 6567.113439685581, 6615.5038372123245, 6765.323467653196, 6787.966060169668, 6789.2871248518195, 6794.116764820542, 6803.693833777393, 6534.411902928759, 6543.5419520633095, 6544.509161812978, 6549.901751473636, 6565.146530950946, 6347.96826015867, 6438.873197190566, 6450.677466126769, 6480.0, 6550.967245163743, 6374.235091789015, 6396.360363963567, 6408.807735767934, 6415.518836087405, 6419.935800641933, 6423.164988551458, 6461.289258181502, 6484.578502397329, 6504.414602685781, 6508.186476690414, 6295.716692748929, 6322.525810564318, 6324.747010119728, 6341.524385671001, 6466.579672321473], "value": 6056.222831137936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.8574656561816, 856.0284077571955, 886.6320477002045, 1140.4126874659546, 1172.630621354274, 30260.84869575652, 40218.59781402185, 41199.17601647965, 41239.793801031024, 41248.58751412485, 41436.37845432321, 41822.0, 41920.790396048054, 41951.16097678045, 41964.531241406556, 7455.366293865028, 7577.16651168371, 7634.427417943649, 7634.427417943649, 7642.159362470152, 7483.62581870907, 7591.5065520741255, 7595.620218989028, 7596.734114306, 7596.962015189944, 7563.848723025536, 7584.772456826304, 7621.0, 7623.390128789683, 7627.694892204333, 7527.887081693779, 7584.62076896153, 7592.772216833504, 7597.430192735567, 7597.620118994056, 7498.587577683225, 7542.396608271325, 7547.396208303323, 7566.772996810105, 7576.848463030764, 37706.0, 37860.81069594635, 37876.24247515062, 37961.0, 38050.42924356137, 3436.4501679731125, 3449.534312867756, 3483.6342184070813, 3484.73864460164, 3487.075924879909, 29613.85193074021, 29692.257693557618, 29716.10851674453, 29875.253118672208, 29924.8503757482, 4702.976485117587, 4745.264484004984, 4805.207140821795, 4831.275308703723, 4858.052679727454, 178658.0, 180303.0, 180402.0, 180439.0, 180603.0, 46747.532524675, 46771.298430523566, 46940.5305946943, 47016.5298347019, 47092.7645361771, 53536.46463535393, 54342.7282863591, 54734.0, 54746.17880731792, 54834.17748733772, 14388.712225755635, 16717.331306747838, 16861.747073793904, 16880.240389182516, 16974.745378819327, 11861.940690296493, 13764.0, 13950.930245348709, 14049.508267210598, 14058.648533786738, 14212.573622791333, 14237.430502779773, 14279.785803212751, 14318.284085795669, 14386.35261413239, 5776.191333213354, 5805.10020946754, 5822.0, 5950.285965684059, 5959.433853783884, 967.1005964453126, 968.1772840182351, 974.541965276319, 1018.1651046142092, 1020.739711373595, 22461.55076898453, 22548.0980760771, 28681.426371472455, 29373.412531749247, 29462.852685736434, 1047.738065483629, 1058.4707646176912, 1073.5276478349501, 1076.311160857052, 1083.8482612434266, 11763.470643821049, 15818.446354377542, 15990.040597563951, 16092.597685057966, 16104.919475402548, 234092.6362945463, 234288.0, 235664.0, 235922.0, 236796.0, 54422.45577544253, 55621.16568251399, 55837.72081139568, 55877.0, 55891.44108558944, 1449.14500444736, 1466.3767898643248, 1479.142097583399, 1481.7481028225227, 1482.3181336585076, 26036.8698156508, 27271.590926135726, 27711.30721731973, 27797.583036254877, 27810.16569502918, 37143.814280928425, 37409.5036198549, 37666.0, 37694.62305377021, 37708.926009068666, 203121.0, 204295.0, 204438.0, 204663.0, 205918.0, 33388.66611333856, 35299.82350088336, 36093.819530902176, 36293.81853090718, 36490.45264320984, 44076.33885491784, 45095.0, 45492.0, 45842.541574583825, 46048.0, 31956.0, 32476.350472990882, 32570.83714581412, 32770.67229327676, 33223.335533288715, 31691.84154079215, 31964.360712786078, 32297.0, 32297.51553726649, 32715.0, 36823.63176368202, 37061.0, 37133.628663714095, 37213.069673257305, 37258.813705931294, 30174.396512070074, 32540.83729581337, 32766.50850237296, 33009.83495082605, 33725.3254934895, 24401.755982439947, 24626.87686561556, 25316.0, 25330.493390132462, 25949.091781788302], "value": 17491.787187006008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5235419008368, 547.8931608336376, 548.4871645011914, 552.8452033430641, 562.9127485239787, 20644.0, 21451.034703438345, 21475.67786483202, 21586.676199856975, 21646.89176554119, 25450.74549254507, 26069.0, 26126.738732612666, 26191.214263572077, 26217.213483595522, 6422.389872962084, 6552.115464412314, 6568.540202185849, 6570.441512471446, 6573.211214654249, 6207.658578778165, 6402.711877965503, 6422.068800023993, 6458.289588145324, 6468.4825213983, 6496.610203387788, 6502.869942601169, 6505.316941721122, 6506.1216735740545, 6506.902396464056, 6464.676766161673, 6472.805815825509, 6477.287498375175, 6486.4162225399705, 6487.059376390421, 5982.341942386334, 5993.670348130851, 6005.399460054004, 6006.429389208019, 6027.427394397525, 25788.0, 27626.309342266402, 28367.290817729514, 28382.0, 28664.713352866413, 1879.990600046991, 1938.3603410874518, 1939.0692467615484, 1939.1273926733027, 1939.1273926733027, 18744.250229990783, 19118.52203694905, 19178.0, 19179.712304315446, 19193.808061919342, 2282.6005449046515, 2316.281952594701, 2337.836351455399, 2343.8593684378993, 2405.398650337416, 131059.34470327683, 137811.31094344665, 139891.0, 140026.0, 140284.0, 13389.732205356033, 14084.929575352262, 14200.431982720576, 14398.064125831788, 14531.346089426, 20134.69797953032, 21038.684419733716, 21120.78879211219, 22243.777562224495, 22264.332070037926, 10435.721354244723, 10495.790084198274, 10585.259031867849, 10611.09805666527, 10816.810150883397, 9977.80044399108, 9998.600055997678, 10078.748031299276, 10131.493425328852, 10154.543045562967, 9039.728808135766, 9200.0, 9244.676436324697, 9334.673286435078, 9376.578053987587, 2522.495500899827, 2529.620556916477, 2581.251437083225, 2645.8544780036896, 2728.0, 913.7487191022522, 933.9252859771202, 938.474454305591, 953.9332246742662, 976.0873583199731, 18013.27946882136, 18438.07809609541, 18834.623307533773, 19183.424497265103, 19385.224591016202, 970.1656575345197, 988.7528117970508, 1019.9796004079877, 1028.1517747858047, 1036.9274150809522, 9836.213102951746, 10491.055804977435, 13121.278329691768, 13212.867871321163, 13507.257100859548, 518763.0, 537936.0, 539121.0, 541988.0, 547530.0, 119167.40416298037, 121105.0, 122492.0, 123314.0, 125280.37359813324, 1224.412282104577, 1248.332142303863, 1267.0, 1280.8847203751707, 1291.6835375333103, 20079.39761807148, 21234.893825530773, 21666.6749998747, 21961.67057494107, 21997.120115195212, 60076.0, 61517.69241153944, 63939.04091438725, 65956.67021665053, 66922.0, 80134.19865801501, 80778.59610701908, 81124.18875811166, 81489.59255203686, 82085.58957205176, 19695.803041969397, 19851.106700198816, 20241.0, 20280.0, 20293.0, 22133.889330553244, 22138.33584992453, 22425.43936401603, 22541.323760287218, 22617.208397706003, 15517.5344739658, 15666.451674191349, 15782.526524204291, 16591.0, 16748.330066797193, 14818.25908704539, 15728.134952577719, 15989.680206395575, 16010.519684409486, 16104.0, 16741.83258167403, 18337.0, 18448.907755461136, 18479.70642055097, 18502.44492665222, 19259.22963081461, 20551.561390702507, 20831.791682082985, 20984.160633574487, 21016.36950891476, 17898.10509474547, 18453.985030823434, 18627.72058419152, 18640.627187456445, 18739.812601873808], "value": 12195.447963737062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.3598836570081, 1335.7662409078414, 1337.9598612041643, 1345.9394327255272, 1360.9115407498514, 13579.592612221637, 13883.652908677288, 14191.290435478224, 14309.785353219697, 14310.785338219936, 14234.928825355884, 14550.272486375692, 14560.781588276184, 14578.635534111627, 14600.342984565694, 2684.2349930269925, 2719.714429984853, 2720.782337413002, 2724.087430710704, 2726.1821453563853, 2557.0922322575498, 2671.8931242750364, 2708.9458210835774, 2714.050082471139, 2716.1172618898836, 2574.884130214145, 2706.9593956090575, 2707.0, 2708.255229811798, 2709.5258329792305, 2691.3944362518473, 2697.393086555529, 2711.7288271172924, 2737.411456536854, 2738.0690565207824, 2640.815142939995, 2656.5351063563994, 2672.545667236555, 2681.7184195659565, 2689.058829409691, 13614.795778063337, 13813.51652692151, 13846.653833654138, 13908.165510069428, 13935.372908219155, 7498.4001279897475, 7742.651580678883, 7774.922250777477, 7784.494007889469, 7812.921870781333, 5040.571551418134, 5052.191649336125, 5175.663581867167, 5261.579073674096, 5270.39390470097, 1684.292597109217, 1689.7549855270918, 1692.2976964559693, 1715.5968347438343, 1745.2320978769428, 23023.884880575657, 23267.0, 23306.184283550163, 23320.533589328286, 23346.18288359899, 6229.470495007885, 6249.9062514062325, 6279.686015699197, 6331.778387756406, 6367.395097465734, 14378.209198494184, 14509.92745036268, 14572.344244509022, 14606.926965365104, 14656.267186640625, 7318.670659820321, 7488.625568721543, 7500.774976750707, 7517.285857843496, 7521.172671006185, 6587.209534855752, 6949.791506254821, 7069.010338552606, 7079.469039822034, 7119.92880071203, 4824.421069471686, 4998.700077995332, 5017.272495488134, 5021.171506701354, 5044.092063428545, 1339.8794108530278, 1414.2151106135987, 1423.459085547506, 1424.1668623854953, 1457.4825936792497, 674.189514474805, 750.7334896111911, 756.1493320014984, 776.3478677910582, 784.2549577900903, 6808.795736127924, 7137.357637812622, 7220.4584656151, 7278.563286202845, 7383.0, 864.4121997042072, 910.2717825739514, 937.8499440089553, 963.2631037256505, 964.3731574476647, 4141.0, 4165.625093741578, 4204.810783514749, 4228.154369126126, 4231.386448964883, 17805.821941780418, 18180.36368727088, 18833.717494237597, 18910.243590256236, 18936.81063189378, 18219.72670409945, 18477.1685274163, 18493.0, 18524.0, 18695.532611684815, 10685.679429617125, 10884.564617415215, 10885.78228435411, 10891.618793342195, 10905.618303359503, 7036.929630703832, 7331.4134869209265, 7468.734542147664, 7501.774946751606, 7530.736424225126, 16442.588935276715, 16728.749068763736, 16935.91532042332, 16959.830401695825, 17387.174346693417, 16390.590235244214, 16622.667546648758, 17147.828521714622, 17230.396936107176, 17357.392491262744, 10926.890731092588, 11247.606333778278, 11294.774104518028, 11306.095512358826, 11307.830382544433, 12577.119601627799, 12577.43401546951, 12806.423710933217, 12983.870161298644, 12996.09027368113, 9896.45569493656, 10084.445355505517, 10507.106895913934, 10540.789184216426, 10600.0, 9187.77030574241, 9666.226701863694, 9985.101340879066, 10183.0, 10246.692599222035, 8194.0, 8463.153684631488, 8602.311815054905, 8738.956305218433, 8750.343724220837, 5638.60529762929, 5856.412235839109, 5893.70531473416, 6265.342139075331, 6286.088517165077, 6169.2288463942, 6502.544821862424, 6627.834304142435, 6786.423154031962, 6810.148731408574], "value": 6132.925257457644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.1959649000207, 480.25080873836816, 503.5920904067703, 506.7567567567568, 508.9541941225289, 6185.134081228632, 6279.748810047598, 6311.463525600318, 6314.336994615563, 6314.526410519206, 5994.8801023979495, 6032.517398608112, 6036.8490787730325, 6088.421599948009, 6149.679173246442, 4810.326554282403, 4828.130936431449, 4923.433805112404, 4937.432195297551, 4966.25506174075, 4931.975340123295, 4944.4313903900975, 4953.0, 4958.727270000149, 4998.250262460624, 4792.329073929653, 4902.117618828609, 4925.236588328797, 4934.925976110361, 4950.504949505039, 4895.437024742147, 4903.117438861003, 4908.680935739166, 4946.653734238605, 4951.975240123812, 4324.848630297956, 4391.8682439526865, 4437.800298986521, 4438.977805110986, 4442.334124703237, 6080.847978800522, 6098.756049758004, 6129.264488261392, 6158.259574489354, 6168.414000669929, 5694.857628559278, 5735.483806457397, 5735.971320143414, 5752.942470575283, 5760.395158508338, 6534.673266336664, 6561.147050883403, 6571.188710547871, 6574.93425065748, 6622.582757293601, 4845.806167753286, 4866.416030076413, 4867.221244600847, 4887.926681099786, 4892.363992680965, 6911.2397636259975, 6964.616946067914, 6978.232394436608, 7002.929970700278, 7006.544574602634, 4892.483330167659, 4904.754762261944, 4904.877378065506, 4907.509249075064, 4928.827491037797, 4953.603711703127, 4954.232094025432, 4955.702657840541, 4958.239824862194, 4985.551300382983, 5543.501084902378, 5547.889042219133, 5590.692511911802, 5596.300462442195, 5629.774809007676, 6392.680365981682, 6461.321561236096, 6474.838129046717, 6485.416312531895, 6616.702248398834, 1667.1247595012474, 1686.3591835102582, 1694.7542606322015, 1729.4898005088278, 1746.8951862888014, 1179.9528018879148, 1197.4970512384818, 1201.2432167734446, 1207.9879201207875, 1212.8423304970474, 5551.0, 5616.079638587993, 5622.493975542221, 5638.126090455986, 5659.207710920475, 6478.514111441661, 6540.345965403421, 6564.770233041821, 6590.670466476657, 6599.934000660028, 5601.943980560224, 5685.459881311269, 5735.512481439041, 5742.483176514133, 5743.0, 3497.3529896969144, 3531.823408829548, 3559.2347645255877, 3559.483874838134, 3607.5851277102943, 6497.545171837926, 6501.707423165969, 6505.251896031922, 6553.901691474632, 6618.602883826889, 6837.897431538531, 6875.831108711531, 6904.275051119661, 6933.341332573397, 6952.791416257521, 6433.356664333529, 6462.095306657072, 6496.252930912911, 6506.642134682544, 6532.771353002622, 6666.666666666744, 6731.85558455054, 6756.223034351113, 6761.208279805954, 6763.86472270542, 6573.375529324707, 6631.750442283343, 6713.1944166700305, 6719.0178897226415, 6741.0, 6508.153939987771, 6518.576292541159, 6568.277489476058, 6592.340765923369, 6622.536422450382, 4917.704937703749, 4918.360613120271, 4947.529984651453, 4955.5044495550155, 4956.851294461172, 6709.664516774239, 6788.86422271542, 6789.1852977643, 6811.93188068113, 6841.076454678555, 6412.39082287182, 6429.38920802523, 6537.70580323877, 6548.246951600627, 6557.131292537426, 6549.967250163719, 6552.6068435894, 6559.6064236145985, 6572.474202063728, 6584.440322572635, 6219.222597175353, 6296.937030629635, 6361.363863613787, 6387.233531976192, 6478.902816457663, 6429.38920802523, 6464.8707025858275, 6464.967675161594, 6531.967340163269, 6540.83647908787, 6250.1874756281395, 6296.244450665949, 6321.620702757849, 6390.7763228286785, 6406.295307516262], "value": 5017.4493034172, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.8366752150848, 901.6573701993243, 917.6375331743957, 917.7430319510537, 919.3059240273592, 16726.414575489845, 17597.296108155675, 17637.029963352026, 17666.205020774065, 21083.57832843342, 19841.305554305603, 21349.0, 21378.786212137875, 21513.354599362006, 21543.6768448473, 963.8602402651611, 989.5794287427815, 991.8710567626199, 991.9752006199867, 993.4734590666958, 1006.3760468509535, 1040.557762950743, 1046.1787496815002, 1048.1405247696891, 1048.2086025051115, 1080.9189310801682, 1090.4765712458025, 1095.4851219926622, 1096.30932512517, 1096.3915027159924, 1075.9778210699867, 1083.025277250473, 1088.1729885287239, 1088.455772113943, 1089.1776708584969, 798.5408390175672, 803.5339503088195, 805.7663277649475, 805.8468890910708, 807.1766797866144, 17890.373836915645, 18315.725264121047, 18413.26346946134, 18434.354797582153, 19547.21811127553, 19981.400557983285, 20007.29974450902, 20668.793312066988, 20750.896245518827, 20801.479963000893, 14677.633059173499, 14985.175815330153, 15040.623984400368, 15047.172405517693, 15055.096694198382, 3406.608240052376, 3455.274392377604, 3465.081753335368, 3508.7193024557973, 3526.647335266453, 116401.0, 121443.39278303552, 125679.0, 125793.0, 128879.0, 15350.385984560493, 15532.844671553139, 15619.219039048003, 15700.68598628021, 15783.447579334668, 28531.0, 28697.85651071773, 28876.0, 29448.11655650334, 29851.253718657208, 7308.488405811542, 8511.702090426805, 9076.636934522678, 9083.318751093695, 9150.954245228731, 4315.482142142901, 4384.868453946387, 4406.889827754268, 4415.139047885696, 4416.227160247008, 5045.394552653705, 5203.037438073969, 5827.562932780059, 6006.5495087868585, 6068.089786532056, 1090.36758679967, 1103.5420300575172, 1124.3254047571393, 1124.5389390349917, 1128.430142777892, 634.22307673101, 635.0949896397707, 644.1497223664811, 647.9190101237346, 666.6000399760202, 10987.780244395228, 11199.160062995308, 11490.599418273398, 11759.88240117605, 11940.402979850973, 635.4217661927623, 660.9834754131089, 671.3521451799037, 684.2815044203567, 688.1123350877413, 5294.57643388528, 5558.888822223533, 6100.389961003864, 6104.114903338991, 6263.185785847902, 96737.51631241798, 97948.51025744969, 98387.0, 98957.0, 100388.49805750925, 84630.57684711537, 85962.57018714867, 89588.5520572393, 90806.54596726975, 93618.53190734003, 70162.64918675374, 71681.0, 73554.63222683853, 74044.0, 75642.62178689182, 11341.149413793833, 12432.627021189379, 12504.187227830162, 12587.307698076327, 12666.43001064936, 34604.48093278653, 34839.30321393609, 35283.647163529065, 35693.643063569034, 36607.084822878576, 61995.0, 63822.0, 65779.67110164418, 66513.33486665071, 67647.66176169088, 18513.722294165327, 18626.72059919075, 18854.434366969013, 18930.52673683169, 18977.810221897606, 20684.58630827345, 20735.79264207399, 21171.682424763334, 21323.893380532998, 21567.568648627253, 18451.354202602844, 18518.44444666662, 19074.046297685338, 19098.904505477385, 19297.131629076444, 17973.37093201732, 18723.157457914152, 18928.905355473136, 18994.715079274098, 19499.902500487406, 17855.37506187277, 18402.907985459988, 18635.254589816257, 19088.236470541022, 19132.904335478233, 12182.573609923611, 12292.938535307267, 12510.562130325396, 12785.16896401731, 12943.09398342107, 13162.670933226364, 13944.651383715489, 14073.648158796112, 14445.133292002514, 14507.274636268356], "value": 8991.578909133052, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 102.0, 109.0, 110.0, 116.0, 110.0, 101.0, 107.0, 110.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 126.0, 146.0, 180.0, 119.0, 142.0, 144.0, 122.0, 175.0, 122.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 168.0, 163.0, 166.0, 163.0, 169.0, 173.0, 164.0, 163.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 172.0, 86.0, 77.0, 75.0, 87.0, 94.0, 75.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 132.0, 79.0, 77.0, 78.0, 125.0, 78.0, 79.0, 125.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 122.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 153.0, 153.0, 152.0, 152.0, 151.0, 152.0, 150.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 55.0, 55.0, 55.0, 63.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 86.0, 82.0, 80.0, 83.0, 80.0, 93.0, 91.0, 80.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 136.0, 131.0, 133.0, 132.0, 129.0, 133.0, 143.0, 172.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 180.0, 177.0, 192.0, 181.0, 183.0, 181.0, 178.0, 182.0, 181.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 67.5, "unit": "score"}]}]} 06:15:24 INFO - Return code: 0 06:15:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:24 INFO - # TBPL SUCCESS # 06:15:24 INFO - Running post-action listener: _package_coverage_data 06:15:24 INFO - Running post-action listener: _resource_record_post_action 06:15:24 INFO - [mozharness: 2017-07-30 13:15:24.893067Z] Finished run-tests step (success) 06:15:24 INFO - Running post-run listener: _resource_record_post_run 06:15:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435515392; Read time: 44; Write time: 251676 06:15:24 INFO - TinderboxPrint: CPU usage
13.1% 06:15:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 44 06:15:24 INFO - TinderboxPrint: I/O write bytes / time
435,515,392 / 251,676 06:15:24 INFO - TinderboxPrint: CPU idle
8,261.9 (86.8%) 06:15:24 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 06:15:24 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109395968; Read time: 0; Write time: 51704 06:15:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:15:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 326119424; Read time: 0; Write time: 199972 06:15:25 INFO - Running post-run listener: _upload_blobber_files 06:15:25 INFO - Blob upload gear active. 06:15:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:25 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 06:15:25 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:25 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:25 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:15:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:15:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:26 INFO - (blobuploader) - INFO - Done attempting. 06:15:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:33 INFO - (blobuploader) - INFO - Done attempting. 06:15:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:15:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:34 INFO - (blobuploader) - INFO - Done attempting. 06:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:35 INFO - (blobuploader) - INFO - Done attempting. 06:15:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:35 INFO - Return code: 0 06:15:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a9bd852c4a20904a69253eafd09ff9a4c33e29d7095bd0e5991239a55900e3a0c1ae5b7240edbfbacb25c5a48b6199bada4d83de41d5b9bf72d553b394e5d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/300a3b461101cf5f594e313bbab69a8ea799c1de919b0a7e6d24b141b9776acc8611328b87a68d0787ee23afb9d064e28d275bc81995d76bf0b1523eba3b569a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49aa71ad0974e5cd7e464d94df88326d330c603b8b32e0bd492857a7ed0f631b3446e47807730f203621a61a5ac2d91ef9191fa3b4b186e168a27e46933e798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb00f7701e71f3cca96c3671b5b9007b30a54879b7c6bf0a364d54fd6d9d0862eb8378646f8711b9edd7ec6d3148291f63b7e5ecd3cdd9c1f71731f3e787b0c3"} 06:15:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:35 INFO - Contents: 06:15:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a9bd852c4a20904a69253eafd09ff9a4c33e29d7095bd0e5991239a55900e3a0c1ae5b7240edbfbacb25c5a48b6199bada4d83de41d5b9bf72d553b394e5d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/300a3b461101cf5f594e313bbab69a8ea799c1de919b0a7e6d24b141b9776acc8611328b87a68d0787ee23afb9d064e28d275bc81995d76bf0b1523eba3b569a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49aa71ad0974e5cd7e464d94df88326d330c603b8b32e0bd492857a7ed0f631b3446e47807730f203621a61a5ac2d91ef9191fa3b4b186e168a27e46933e798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb00f7701e71f3cca96c3671b5b9007b30a54879b7c6bf0a364d54fd6d9d0862eb8378646f8711b9edd7ec6d3148291f63b7e5ecd3cdd9c1f71731f3e787b0c3"} 06:15:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:35 INFO - Copying logs to upload dir... 06:15:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.412787 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-30 06:15:34.474219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:34.487235) ========= 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=0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a9bd852c4a20904a69253eafd09ff9a4c33e29d7095bd0e5991239a55900e3a0c1ae5b7240edbfbacb25c5a48b6199bada4d83de41d5b9bf72d553b394e5d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/300a3b461101cf5f594e313bbab69a8ea799c1de919b0a7e6d24b141b9776acc8611328b87a68d0787ee23afb9d064e28d275bc81995d76bf0b1523eba3b569a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49aa71ad0974e5cd7e464d94df88326d330c603b8b32e0bd492857a7ed0f631b3446e47807730f203621a61a5ac2d91ef9191fa3b4b186e168a27e46933e798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb00f7701e71f3cca96c3671b5b9007b30a54879b7c6bf0a364d54fd6d9d0862eb8378646f8711b9edd7ec6d3148291f63b7e5ecd3cdd9c1f71731f3e787b0c3"} build_url:https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/B8fC0UWOT0Oorcf49xoIZw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a9bd852c4a20904a69253eafd09ff9a4c33e29d7095bd0e5991239a55900e3a0c1ae5b7240edbfbacb25c5a48b6199bada4d83de41d5b9bf72d553b394e5d3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/300a3b461101cf5f594e313bbab69a8ea799c1de919b0a7e6d24b141b9776acc8611328b87a68d0787ee23afb9d064e28d275bc81995d76bf0b1523eba3b569a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c49aa71ad0974e5cd7e464d94df88326d330c603b8b32e0bd492857a7ed0f631b3446e47807730f203621a61a5ac2d91ef9191fa3b4b186e168a27e46933e798", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cb00f7701e71f3cca96c3671b5b9007b30a54879b7c6bf0a364d54fd6d9d0862eb8378646f8711b9edd7ec6d3148291f63b7e5ecd3cdd9c1f71731f3e787b0c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:34.511637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:34.518167) ========= 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=0e2a256762fed810e2f0f810000001b3-1501411430.484088-346920671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 06:15:34.595754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 06:15:34.596070) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 06:15:34.596363) ========= ========= Total master_lag: 0.28 =========