builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1501229302.77 results: success (0) revision: 5845151f1a2cd00957fdd48e204542ccbdfaba1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.766590) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.767042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.767338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.784011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.784769) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 01:08:23-- 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% 42.2M=0s 2017-07-28 01:08:23 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.923530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.923850) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018438 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.973691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:22.974013) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5845151f1a2cd00957fdd48e204542ccbdfaba1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 5845151f1a2cd00957fdd48e204542ccbdfaba1e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 01:08:23,515 truncating revision to first 12 chars 2017-07-28 01:08:23,515 Setting DEBUG logging. 2017-07-28 01:08:23,515 attempt 1/10 2017-07-28 01:08:23,515 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5845151f1a2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-28 01:08:24,052 unpacking tar archive at: mozilla-central-5845151f1a2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:23.963413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:23.963754) ========= script_repo_revision: 5845151f1a2cd00957fdd48e204542ccbdfaba1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:23.964175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:23.964455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 01:08:23.972913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-28 01:08:23.973247) ========= /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=3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:24 INFO - MultiFileLogger online at 20170728 01:08:24 in /builds/slave/test 01:08:24 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 01:08:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:08:24 INFO - {'append_to_log': False, 01:08:24 INFO - 'base_work_dir': '/builds/slave/test', 01:08:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:08:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:08:24 INFO - 'branch': 'Firefox-Non-PGO', 01:08:24 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:24 INFO - 'code_coverage': False, 01:08:24 INFO - 'config_files': ('talos/linux_config.py',), 01:08:24 INFO - 'default_actions': ('clobber', 01:08:24 INFO - 'read-buildbot-config', 01:08:24 INFO - 'download-and-extract', 01:08:24 INFO - 'populate-webroot', 01:08:24 INFO - 'create-virtualenv', 01:08:24 INFO - 'install', 01:08:24 INFO - 'setup-mitmproxy', 01:08:24 INFO - 'run-tests'), 01:08:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:24 INFO - 'disable_ccov_upload': False, 01:08:24 INFO - 'download_minidump_stackwalk': True, 01:08:24 INFO - 'download_symbols': 'ondemand', 01:08:24 INFO - 'enable_stylo': False, 01:08:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:24 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:24 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:24 INFO - 'gecko_profile': False, 01:08:24 INFO - 'gecko_profile_interval': 0, 01:08:24 INFO - 'installer_path': 'installer.exe', 01:08:24 INFO - 'log_level': 'info', 01:08:24 INFO - 'log_name': 'talos', 01:08:24 INFO - 'log_to_console': True, 01:08:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:24 INFO - 'opt_config_files': (), 01:08:24 INFO - 'pip_index': False, 01:08:24 INFO - 'suite': 'dromaeojs-e10s', 01:08:24 INFO - 'system_bits': '32', 01:08:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:24 INFO - 'title': 'talos-linux64-ix-083', 01:08:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:24 INFO - 'use_talos_json': True, 01:08:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:24 INFO - 'work_dir': 'build'} 01:08:24 INFO - [mozharness: 2017-07-28 08:08:24.611915Z] Running clobber step. 01:08:24 INFO - Running pre-action listener: _resource_record_pre_action 01:08:24 INFO - Running main action method: clobber 01:08:24 INFO - rmtree: /builds/slave/test/build 01:08:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:26 INFO - Running post-action listener: _resource_record_post_action 01:08:26 INFO - [mozharness: 2017-07-28 08:08:26.153975Z] Finished clobber step (success) 01:08:26 INFO - [mozharness: 2017-07-28 08:08:26.154077Z] Running read-buildbot-config step. 01:08:26 INFO - Running pre-action listener: _resource_record_pre_action 01:08:26 INFO - Running main action method: read_buildbot_config 01:08:26 INFO - Using buildbot properties: 01:08:26 INFO - { 01:08:26 INFO - "project": "", 01:08:26 INFO - "product": "firefox", 01:08:26 INFO - "who": "cbook@mozilla.com", 01:08:26 INFO - "installer_path": "public/build/target.tar.bz2", 01:08:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:08:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 01:08:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 01:08:26 INFO - "stage_platform": "linux64", 01:08:26 INFO - "basedir": "/builds/slave/test", 01:08:26 INFO - "buildnumber": 1041, 01:08:26 INFO - "platform": "ubuntu64_hw", 01:08:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:08:26 INFO - "slavebuilddir": "test", 01:08:26 INFO - "taskId": "Jb7x1GKFQEC6OZtfu3mhpg", 01:08:26 INFO - "branch": "mozilla-central", 01:08:26 INFO - "script_repo_revision": "production", 01:08:26 INFO - "revision": "5845151f1a2cd00957fdd48e204542ccbdfaba1e", 01:08:26 INFO - "slavename": "talos-linux64-ix-083", 01:08:26 INFO - "repo_path": "mozilla-central" 01:08:26 INFO - } 01:08:26 INFO - Finding installer, test and symbols from parent task. 01:08:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jb7x1GKFQEC6OZtfu3mhpg'}, attempt #1 01:08:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jb7x1GKFQEC6OZtfu3mhpg'}, attempt #1 01:08:27 INFO - Task dependencies: Q_0oAkbmSxa4brTQ_KIZPg 01:08:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg'}, attempt #1 01:08:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:08:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/test_packages.json 01:08:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip 01:08:27 INFO - Running post-action listener: _resource_record_post_action 01:08:27 INFO - [mozharness: 2017-07-28 08:08:27.473555Z] Finished read-buildbot-config step (success) 01:08:27 INFO - [mozharness: 2017-07-28 08:08:27.473786Z] Running download-and-extract step. 01:08:27 INFO - Running pre-action listener: _resource_record_pre_action 01:08:27 INFO - Running main action method: download_and_extract 01:08:27 INFO - mkdir: /builds/slave/test/build/tests 01:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:27 INFO - trying https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json 01:08:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:08:28 INFO - Downloaded 989 bytes. 01:08:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:08:28 INFO - Using the following test package requirements: 01:08:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:08:28 INFO - u'common': [u'target.common.tests.zip'], 01:08:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:08:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:08:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:08:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:08:28 INFO - u'mozbase': [u'target.common.tests.zip'], 01:08:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:08:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:08:28 INFO - u'web-platform': [u'target.common.tests.zip', 01:08:28 INFO - u'target.web-platform.tests.tar.gz'], 01:08:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:08:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:08:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip 01:08:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:08:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip into memory 01:08:29 INFO - Content-Length response header: 72561179 01:08:29 INFO - Bytes received: 72561179 01:08:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:08:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip 01:08:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:08:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.common.tests.zip into memory 01:08:41 INFO - Content-Length response header: 72561179 01:08:41 INFO - Bytes received: 72561179 01:08:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip 01:08:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:08:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.talos.tests.zip into memory 01:08:54 INFO - Content-Length response header: 14496465 01:08:54 INFO - Bytes received: 14496465 01:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:54 INFO - trying https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:08:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:08:56 INFO - Downloaded 62069301 bytes. 01:08:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:08:56 INFO - mkdir: /builds/slave/test/properties 01:08:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:08:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:08:56 INFO - Contents: 01:08:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 01:08:56 INFO - Running post-action listener: _resource_record_post_action 01:08:56 INFO - Running post-action listener: set_extra_try_arguments 01:08:56 INFO - [mozharness: 2017-07-28 08:08:56.484671Z] Finished download-and-extract step (success) 01:08:56 INFO - [mozharness: 2017-07-28 08:08:56.484768Z] Running populate-webroot step. 01:08:56 INFO - Running pre-action listener: _resource_record_pre_action 01:08:56 INFO - Running main action method: populate_webroot 01:08:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:08:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:08:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:08:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:08:56 INFO - 'tests': ['damp', 'tps']}, 01:08:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:08:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:08:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:08:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:08:56 INFO - 'other-e10s': {'tests': ['a11yr', 01:08:56 INFO - 'ts_paint', 01:08:56 INFO - 'tpaint', 01:08:56 INFO - 'sessionrestore', 01:08:56 INFO - 'sessionrestore_many_windows', 01:08:56 INFO - 'sessionrestore_no_auto_restore', 01:08:56 INFO - 'tabpaint']}, 01:08:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 01:08:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 01:08:56 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:08:56 INFO - 'talos_options': ['--mitmproxy', 01:08:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:08:56 INFO - '--firstNonBlankPaint'], 01:08:56 INFO - 'tests': ['quantum_pageload_google', 01:08:56 INFO - 'quantum_pageload_youtube', 01:08:56 INFO - 'quantum_pageload_amazon', 01:08:56 INFO - 'quantum_pageload_facebook']}, 01:08:56 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:08:56 INFO - 'talos_options': ['--stylo', 01:08:56 INFO - '--mitmproxy', 01:08:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:08:56 INFO - '--firstNonBlankPaint'], 01:08:56 INFO - 'tests': ['quantum_pageload_google', 01:08:56 INFO - 'quantum_pageload_youtube', 01:08:56 INFO - 'quantum_pageload_amazon', 01:08:56 INFO - 'quantum_pageload_facebook']}, 01:08:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:08:56 INFO - 'tsvgr_opacity', 01:08:56 INFO - 'tart', 01:08:56 INFO - 'tscrollx', 01:08:56 INFO - 'cart', 01:08:56 INFO - 'tsvg_static']}, 01:08:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:08:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:08:56 INFO - 'talos_options': ['--xperf_path', 01:08:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:56 INFO - 'tests': ['tp5n']}}} 01:08:56 INFO - Running post-action listener: _resource_record_post_action 01:08:56 INFO - [mozharness: 2017-07-28 08:08:56.492066Z] Finished populate-webroot step (success) 01:08:56 INFO - [mozharness: 2017-07-28 08:08:56.492157Z] Running create-virtualenv step. 01:08:56 INFO - Running pre-action listener: _resource_record_pre_action 01:08:56 INFO - Running main action method: create_virtualenv 01:08:56 INFO - Creating virtualenv /builds/slave/test/build/venv 01:08:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:08:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:08:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 01:08:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:08:56 INFO - Using real prefix '/usr' 01:08:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:08:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:59 INFO - Installing pip.................done. 01:08:59 INFO - Return code: 0 01:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:08:59 INFO - Reading from file tmpfile_stdout 01:08:59 INFO - Output received: 01:08:59 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:08:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:59 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:08:59 INFO - Using env: {'DISPLAY': ':0', 01:08:59 INFO - 'HOME': '/home/cltbld', 01:08:59 INFO - 'LANG': 'en_US.UTF-8', 01:08:59 INFO - 'LANGUAGE': 'en_US:en', 01:08:59 INFO - 'LOGNAME': 'cltbld', 01:08:59 INFO - 'MAIL': '/var/mail/cltbld', 01:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:59 INFO - 'MOZ_NO_REMOTE': '1', 01:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:59 INFO - 'NO_EM_RESTART': '1', 01:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:59 INFO - 'PWD': '/builds/slave/test', 01:08:59 INFO - 'SHELL': '/bin/bash', 01:08:59 INFO - 'SHLVL': '1', 01:08:59 INFO - 'TERM': 'linux', 01:08:59 INFO - 'TMOUT': '86400', 01:08:59 INFO - 'USER': 'cltbld', 01:08:59 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:59 INFO - '_': '/tools/buildbot/bin/python'} 01:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:08:59 INFO - Cleaning up... 01:08:59 INFO - Return code: 0 01:08:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:59 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:08:59 INFO - Using env: {'DISPLAY': ':0', 01:08:59 INFO - 'HOME': '/home/cltbld', 01:08:59 INFO - 'LANG': 'en_US.UTF-8', 01:08:59 INFO - 'LANGUAGE': 'en_US:en', 01:08:59 INFO - 'LOGNAME': 'cltbld', 01:08:59 INFO - 'MAIL': '/var/mail/cltbld', 01:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:59 INFO - 'MOZ_NO_REMOTE': '1', 01:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:59 INFO - 'NO_EM_RESTART': '1', 01:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:59 INFO - 'PWD': '/builds/slave/test', 01:08:59 INFO - 'SHELL': '/bin/bash', 01:08:59 INFO - 'SHLVL': '1', 01:08:59 INFO - 'TERM': 'linux', 01:08:59 INFO - 'TMOUT': '86400', 01:08:59 INFO - 'USER': 'cltbld', 01:08:59 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:59 INFO - '_': '/tools/buildbot/bin/python'} 01:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:59 INFO - Downloading/unpacking psutil>=3.1.1 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:09:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:00 INFO - Installing collected packages: psutil 01:09:00 INFO - Running setup.py install for psutil 01:09:00 INFO - building 'psutil._psutil_linux' extension 01:09:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:09:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:09:01 INFO - building 'psutil._psutil_posix' extension 01:09:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:09:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:01 INFO - Successfully installed psutil 01:09:01 INFO - Cleaning up... 01:09:01 INFO - Return code: 0 01:09:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:01 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:09:01 INFO - Using env: {'DISPLAY': ':0', 01:09:01 INFO - 'HOME': '/home/cltbld', 01:09:01 INFO - 'LANG': 'en_US.UTF-8', 01:09:01 INFO - 'LANGUAGE': 'en_US:en', 01:09:01 INFO - 'LOGNAME': 'cltbld', 01:09:01 INFO - 'MAIL': '/var/mail/cltbld', 01:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:01 INFO - 'MOZ_NO_REMOTE': '1', 01:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:01 INFO - 'NO_EM_RESTART': '1', 01:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:01 INFO - 'PWD': '/builds/slave/test', 01:09:01 INFO - 'SHELL': '/bin/bash', 01:09:01 INFO - 'SHLVL': '1', 01:09:01 INFO - 'TERM': 'linux', 01:09:01 INFO - 'TMOUT': '86400', 01:09:01 INFO - 'USER': 'cltbld', 01:09:01 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:01 INFO - '_': '/tools/buildbot/bin/python'} 01:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:09:02 INFO - Installing collected packages: mozsystemmonitor 01:09:02 INFO - Running setup.py install for mozsystemmonitor 01:09:02 INFO - Successfully installed mozsystemmonitor 01:09:02 INFO - Cleaning up... 01:09:02 INFO - Return code: 0 01:09:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:02 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:09:02 INFO - Using env: {'DISPLAY': ':0', 01:09:02 INFO - 'HOME': '/home/cltbld', 01:09:02 INFO - 'LANG': 'en_US.UTF-8', 01:09:02 INFO - 'LANGUAGE': 'en_US:en', 01:09:02 INFO - 'LOGNAME': 'cltbld', 01:09:02 INFO - 'MAIL': '/var/mail/cltbld', 01:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:02 INFO - 'MOZ_NO_REMOTE': '1', 01:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:02 INFO - 'NO_EM_RESTART': '1', 01:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:02 INFO - 'PWD': '/builds/slave/test', 01:09:02 INFO - 'SHELL': '/bin/bash', 01:09:02 INFO - 'SHLVL': '1', 01:09:02 INFO - 'TERM': 'linux', 01:09:02 INFO - 'TMOUT': '86400', 01:09:02 INFO - 'USER': 'cltbld', 01:09:02 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:02 INFO - '_': '/tools/buildbot/bin/python'} 01:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:03 INFO - Downloading/unpacking jsonschema==2.5.1 01:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:04 INFO - warning: no files found matching '*.txt' 01:09:04 INFO - no previously-included directories found matching 'build' 01:09:04 INFO - no previously-included directories found matching 'dist' 01:09:04 INFO - no previously-included directories found matching '.git*' 01:09:04 INFO - Installing collected packages: jsonschema, functools32 01:09:04 INFO - Running setup.py install for functools32 01:09:04 INFO - warning: no files found matching '*.txt' 01:09:04 INFO - no previously-included directories found matching 'build' 01:09:04 INFO - no previously-included directories found matching 'dist' 01:09:04 INFO - no previously-included directories found matching '.git*' 01:09:04 INFO - Successfully installed jsonschema functools32 01:09:04 INFO - Cleaning up... 01:09:04 INFO - Return code: 0 01:09:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:04 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:09:04 INFO - Using env: {'DISPLAY': ':0', 01:09:04 INFO - 'HOME': '/home/cltbld', 01:09:04 INFO - 'LANG': 'en_US.UTF-8', 01:09:04 INFO - 'LANGUAGE': 'en_US:en', 01:09:04 INFO - 'LOGNAME': 'cltbld', 01:09:04 INFO - 'MAIL': '/var/mail/cltbld', 01:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:04 INFO - 'MOZ_NO_REMOTE': '1', 01:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:04 INFO - 'NO_EM_RESTART': '1', 01:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:04 INFO - 'PWD': '/builds/slave/test', 01:09:04 INFO - 'SHELL': '/bin/bash', 01:09:04 INFO - 'SHLVL': '1', 01:09:04 INFO - 'TERM': 'linux', 01:09:04 INFO - 'TMOUT': '86400', 01:09:04 INFO - 'USER': 'cltbld', 01:09:04 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:04 INFO - '_': '/tools/buildbot/bin/python'} 01:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:09:04 INFO - Cleaning up... 01:09:04 INFO - Return code: 0 01:09:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:04 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:09:04 INFO - Using env: {'DISPLAY': ':0', 01:09:04 INFO - 'HOME': '/home/cltbld', 01:09:04 INFO - 'LANG': 'en_US.UTF-8', 01:09:04 INFO - 'LANGUAGE': 'en_US:en', 01:09:04 INFO - 'LOGNAME': 'cltbld', 01:09:04 INFO - 'MAIL': '/var/mail/cltbld', 01:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:04 INFO - 'MOZ_NO_REMOTE': '1', 01:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:04 INFO - 'NO_EM_RESTART': '1', 01:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:04 INFO - 'PWD': '/builds/slave/test', 01:09:04 INFO - 'SHELL': '/bin/bash', 01:09:04 INFO - 'SHLVL': '1', 01:09:04 INFO - 'TERM': 'linux', 01:09:04 INFO - 'TMOUT': '86400', 01:09:04 INFO - 'USER': 'cltbld', 01:09:04 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:04 INFO - '_': '/tools/buildbot/bin/python'} 01:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:07 INFO - Downloading docopt-0.6.1.tar.gz 01:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:07 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:07 INFO - Running setup.py install for blobuploader 01:09:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:07 INFO - Running setup.py install for requests 01:09:08 INFO - Running setup.py install for docopt 01:09:08 INFO - Successfully installed blobuploader requests docopt 01:09:08 INFO - Cleaning up... 01:09:08 INFO - Return code: 0 01:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:08 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:09:08 INFO - Using env: {'DISPLAY': ':0', 01:09:08 INFO - 'HOME': '/home/cltbld', 01:09:08 INFO - 'LANG': 'en_US.UTF-8', 01:09:08 INFO - 'LANGUAGE': 'en_US:en', 01:09:08 INFO - 'LOGNAME': 'cltbld', 01:09:08 INFO - 'MAIL': '/var/mail/cltbld', 01:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:08 INFO - 'MOZ_NO_REMOTE': '1', 01:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:08 INFO - 'NO_EM_RESTART': '1', 01:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:08 INFO - 'PWD': '/builds/slave/test', 01:09:08 INFO - 'SHELL': '/bin/bash', 01:09:08 INFO - 'SHLVL': '1', 01:09:08 INFO - 'TERM': 'linux', 01:09:08 INFO - 'TMOUT': '86400', 01:09:08 INFO - 'USER': 'cltbld', 01:09:08 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:08 INFO - '_': '/tools/buildbot/bin/python'} 01:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:08 INFO - Running setup.py (path:/tmp/pip-rTqre7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:08 INFO - Running setup.py (path:/tmp/pip-KwIIPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:08 INFO - Running setup.py (path:/tmp/pip-Bkvg_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:08 INFO - Running setup.py (path:/tmp/pip-0G2Ytc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:08 INFO - Running setup.py (path:/tmp/pip-rszPlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:08 INFO - Running setup.py (path:/tmp/pip-ALxmR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:08 INFO - Running setup.py (path:/tmp/pip-UcVaUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:08 INFO - Running setup.py (path:/tmp/pip-ab8fyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:09 INFO - Running setup.py (path:/tmp/pip-QClINi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:09 INFO - Running setup.py (path:/tmp/pip-tinyJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:09 INFO - Running setup.py (path:/tmp/pip-S0oNW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:09 INFO - Running setup.py (path:/tmp/pip-MEilwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:09 INFO - Running setup.py (path:/tmp/pip-pD27z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:09 INFO - Running setup.py (path:/tmp/pip-nUF_VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:09 INFO - Running setup.py (path:/tmp/pip-G95hEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:09 INFO - Running setup.py (path:/tmp/pip-cPS2TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:09 INFO - Running setup.py (path:/tmp/pip-uUA_iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:09 INFO - Running setup.py install for manifestparser 01:09:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:09 INFO - Running setup.py install for mozcrash 01:09:09 INFO - Running setup.py install for mozdebug 01:09:10 INFO - Running setup.py install for mozdevice 01:09:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Running setup.py install for mozfile 01:09:10 INFO - Running setup.py install for mozhttpd 01:09:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Running setup.py install for mozinfo 01:09:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Running setup.py install for mozInstall 01:09:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Running setup.py install for mozleak 01:09:10 INFO - Running setup.py install for mozlog 01:09:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Running setup.py install for moznetwork 01:09:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:10 INFO - Running setup.py install for mozprocess 01:09:10 INFO - Running setup.py install for mozprofile 01:09:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:11 INFO - Running setup.py install for mozrunner 01:09:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:11 INFO - Running setup.py install for mozscreenshot 01:09:11 INFO - Running setup.py install for moztest 01:09:11 INFO - Running setup.py install for mozversion 01:09:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:11 INFO - Cleaning up... 01:09:11 INFO - Return code: 0 01:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:09:11 INFO - Using env: {'DISPLAY': ':0', 01:09:11 INFO - 'HOME': '/home/cltbld', 01:09:11 INFO - 'LANG': 'en_US.UTF-8', 01:09:11 INFO - 'LANGUAGE': 'en_US:en', 01:09:11 INFO - 'LOGNAME': 'cltbld', 01:09:11 INFO - 'MAIL': '/var/mail/cltbld', 01:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:11 INFO - 'MOZ_NO_REMOTE': '1', 01:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:11 INFO - 'NO_EM_RESTART': '1', 01:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:11 INFO - 'PWD': '/builds/slave/test', 01:09:11 INFO - 'SHELL': '/bin/bash', 01:09:11 INFO - 'SHLVL': '1', 01:09:11 INFO - 'TERM': 'linux', 01:09:11 INFO - 'TMOUT': '86400', 01:09:11 INFO - 'USER': 'cltbld', 01:09:11 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:11 INFO - '_': '/tools/buildbot/bin/python'} 01:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:11 INFO - Running setup.py (path:/tmp/pip-N8J5rO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:11 INFO - Running setup.py (path:/tmp/pip-2n1co5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:11 INFO - Running setup.py (path:/tmp/pip-q2duZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:11 INFO - Running setup.py (path:/tmp/pip-aVcOPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:12 INFO - Running setup.py (path:/tmp/pip-tcRI4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:12 INFO - Running setup.py (path:/tmp/pip-_ywmq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:12 INFO - Running setup.py (path:/tmp/pip-NN1m2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:12 INFO - Running setup.py (path:/tmp/pip-oJf5r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:12 INFO - Running setup.py (path:/tmp/pip-XMUeTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:12 INFO - Running setup.py (path:/tmp/pip-lshmCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:12 INFO - Running setup.py (path:/tmp/pip-BrAyKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:12 INFO - Running setup.py (path:/tmp/pip-eQ3gYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:12 INFO - Running setup.py (path:/tmp/pip-L3Hf8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:12 INFO - Running setup.py (path:/tmp/pip-i1j11v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:12 INFO - Running setup.py (path:/tmp/pip-zADguC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:12 INFO - Running setup.py (path:/tmp/pip-cPgvBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:12 INFO - Running setup.py (path:/tmp/pip-sxOiQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:09:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:14 INFO - Downloading blessings-1.6.tar.gz 01:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:14 INFO - Installing collected packages: blessings 01:09:14 INFO - Running setup.py install for blessings 01:09:14 INFO - Successfully installed blessings 01:09:14 INFO - Cleaning up... 01:09:14 INFO - Return code: 0 01:09:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:14 INFO - Reading from file tmpfile_stdout 01:09:14 INFO - Current package versions: 01:09:14 INFO - argparse == 1.2.1 01:09:14 INFO - blessings == 1.6 01:09:14 INFO - blobuploader == 1.2.4 01:09:14 INFO - docopt == 0.6.1 01:09:14 INFO - functools32 == 3.2.3-2 01:09:14 INFO - jsonschema == 2.5.1 01:09:14 INFO - manifestparser == 1.1 01:09:14 INFO - mozInstall == 1.13 01:09:14 INFO - mozcrash == 1.0 01:09:14 INFO - mozdebug == 0.1 01:09:14 INFO - mozdevice == 0.51 01:09:14 INFO - mozfile == 1.2 01:09:14 INFO - mozhttpd == 0.7 01:09:14 INFO - mozinfo == 0.10 01:09:14 INFO - mozleak == 0.1 01:09:14 INFO - mozlog == 3.5 01:09:14 INFO - moznetwork == 0.27 01:09:14 INFO - mozprocess == 0.25 01:09:14 INFO - mozprofile == 0.28 01:09:14 INFO - mozrunner == 6.13 01:09:14 INFO - mozscreenshot == 0.1 01:09:14 INFO - mozsystemmonitor == 0.3 01:09:14 INFO - moztest == 0.8 01:09:14 INFO - mozversion == 1.4 01:09:14 INFO - psutil == 3.1.1 01:09:14 INFO - requests == 1.2.3 01:09:14 INFO - wsgiref == 0.1.2 01:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:09:14 INFO - Using env: {'DISPLAY': ':0', 01:09:14 INFO - 'HOME': '/home/cltbld', 01:09:14 INFO - 'LANG': 'en_US.UTF-8', 01:09:14 INFO - 'LANGUAGE': 'en_US:en', 01:09:14 INFO - 'LOGNAME': 'cltbld', 01:09:14 INFO - 'MAIL': '/var/mail/cltbld', 01:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:14 INFO - 'MOZ_NO_REMOTE': '1', 01:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:14 INFO - 'NO_EM_RESTART': '1', 01:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:14 INFO - 'PWD': '/builds/slave/test', 01:09:14 INFO - 'SHELL': '/bin/bash', 01:09:14 INFO - 'SHLVL': '1', 01:09:14 INFO - 'TERM': 'linux', 01:09:14 INFO - 'TMOUT': '86400', 01:09:14 INFO - 'USER': 'cltbld', 01:09:14 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:14 INFO - '_': '/tools/buildbot/bin/python'} 01:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:09:14 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:15 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:09:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 01:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 01:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:09:16 INFO - Installing collected packages: marionette-driver, simplejson 01:09:16 INFO - Running setup.py install for marionette-driver 01:09:16 INFO - Running setup.py install for simplejson 01:09:16 INFO - building 'simplejson._speedups' extension 01:09:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 01:09:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 01:09:17 INFO - Successfully installed marionette-driver simplejson 01:09:17 INFO - Cleaning up... 01:09:17 INFO - Return code: 0 01:09:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2886a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a29d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:09:17 INFO - Using env: {'DISPLAY': ':0', 01:09:17 INFO - 'HOME': '/home/cltbld', 01:09:17 INFO - 'LANG': 'en_US.UTF-8', 01:09:17 INFO - 'LANGUAGE': 'en_US:en', 01:09:17 INFO - 'LOGNAME': 'cltbld', 01:09:17 INFO - 'MAIL': '/var/mail/cltbld', 01:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:17 INFO - 'MOZ_NO_REMOTE': '1', 01:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:17 INFO - 'NO_EM_RESTART': '1', 01:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:17 INFO - 'PWD': '/builds/slave/test', 01:09:17 INFO - 'SHELL': '/bin/bash', 01:09:17 INFO - 'SHLVL': '1', 01:09:17 INFO - 'TERM': 'linux', 01:09:17 INFO - 'TMOUT': '86400', 01:09:17 INFO - 'USER': 'cltbld', 01:09:17 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:17 INFO - '_': '/tools/buildbot/bin/python'} 01:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:09:17 INFO - Cleaning up... 01:09:17 INFO - Return code: 0 01:09:17 INFO - Running post-action listener: _resource_record_post_action 01:09:17 INFO - Running post-action listener: _start_resource_monitoring 01:09:17 INFO - Starting resource monitoring. 01:09:17 INFO - [mozharness: 2017-07-28 08:09:17.548931Z] Finished create-virtualenv step (success) 01:09:17 INFO - [mozharness: 2017-07-28 08:09:17.549395Z] Running install step. 01:09:17 INFO - Running pre-action listener: _resource_record_pre_action 01:09:17 INFO - Running main action method: install 01:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:17 INFO - Reading from file tmpfile_stdout 01:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:17 INFO - Reading from file tmpfile_stdout 01:09:17 INFO - Output received: 01:09:17 INFO - Usage: mozinstall [options] installer 01:09:17 INFO - Options: 01:09:17 INFO - -h, --help show this help message and exit 01:09:17 INFO - -d DEST, --destination=DEST 01:09:17 INFO - Directory to install application into. [default: 01:09:17 INFO - "/builds/slave/test"] 01:09:17 INFO - --app=APP Application being installed. [default: firefox] 01:09:17 INFO - mkdir: /builds/slave/test/build/application 01:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:09:35 INFO - Reading from file tmpfile_stdout 01:09:35 INFO - Output received: 01:09:35 INFO - /builds/slave/test/build/application/firefox/firefox 01:09:35 INFO - Running post-action listener: _resource_record_post_action 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.979603Z] Finished install step (success) 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.979860Z] Running setup-mitmproxy step. 01:09:35 INFO - Running pre-action listener: _resource_record_pre_action 01:09:35 INFO - Running main action method: setup_mitmproxy 01:09:35 INFO - Skipping: mitmproxy is not required 01:09:35 INFO - Running post-action listener: _resource_record_post_action 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.980998Z] Finished setup-mitmproxy step (success) 01:09:35 INFO - [mozharness: 2017-07-28 08:09:35.981222Z] Running run-tests step. 01:09:35 INFO - Running pre-action listener: _resource_record_pre_action 01:09:35 INFO - Running pre-action listener: _set_gcov_prefix 01:09:35 INFO - Running main action method: run_tests 01:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:09:35 INFO - Python 2.7.3 01:09:35 INFO - Return code: 0 01:09:35 INFO - grabbing minidump binary from tooltool 01:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:35 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 0x2a26eb0>, '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 0x2a27db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a28240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:09:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:09:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:09:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:09:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:09:36 INFO - Return code: 0 01:09:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:09:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:09:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:09:36 INFO - ENV: RUST_BACKTRACE is now 1 01:09:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:09:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:09:36 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:09:36 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:09:36 INFO - Using env: {'DISPLAY': ':0', 01:09:36 INFO - 'HOME': '/home/cltbld', 01:09:36 INFO - 'LANG': 'en_US.UTF-8', 01:09:36 INFO - 'LANGUAGE': 'en_US:en', 01:09:36 INFO - 'LOGNAME': 'cltbld', 01:09:36 INFO - 'MAIL': '/var/mail/cltbld', 01:09:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:09:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:36 INFO - 'MOZ_NO_REMOTE': '1', 01:09:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:36 INFO - 'NO_EM_RESTART': '1', 01:09:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:36 INFO - 'PWD': '/builds/slave/test', 01:09:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:09:36 INFO - 'RUST_BACKTRACE': '1', 01:09:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:09:36 INFO - 'SHELL': '/bin/bash', 01:09:36 INFO - 'SHLVL': '1', 01:09:36 INFO - 'TERM': 'linux', 01:09:36 INFO - 'TMOUT': '86400', 01:09:36 INFO - 'USER': 'cltbld', 01:09:36 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837', 01:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:36 INFO - '_': '/tools/buildbot/bin/python'} 01:09:36 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/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:09:36 INFO - mozversion application_buildid: 20170728072256 01:09:36 INFO - mozversion application_changeset: 5845151f1a2cd00957fdd48e204542ccbdfaba1e 01:09:36 INFO - mozversion application_display_name: Nightly 01:09:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:09:36 INFO - mozversion application_name: Firefox 01:09:36 INFO - mozversion application_remotingname: firefox 01:09:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:09:36 INFO - mozversion application_vendor: Mozilla 01:09:36 INFO - mozversion application_version: 56.0a1 01:09:36 INFO - mozversion platform_buildid: 20170728072256 01:09:36 INFO - mozversion platform_changeset: 5845151f1a2cd00957fdd48e204542ccbdfaba1e 01:09:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:09:36 INFO - mozversion platform_version: 56.0a1 01:09:36 INFO - using testdate: 1501229376 01:09:36 INFO - actual date: 1501229376 01:09:36 INFO - starting webserver on 'localhost:48689' 01:09:36 INFO - SUITE-START | Running 2 tests 01:09:36 INFO - TEST-START | dromaeo_css 01:09:36 INFO - Initialising browser for dromaeo_css test... 01:09:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48689/getInfo.html -profile /tmp/tmpTGH5N9/profile 01:09:36 INFO - TEST-INFO | started process 13193 (/builds/slave/test/build/application/firefox/firefox http://localhost:48689/getInfo.html) 01:09:42 INFO - TEST-INFO | 13193: exit 0 01:09:42 INFO - Browser initialized. 01:09:42 INFO - Running cycle 1/1 for dromaeo_css test... 01:09:42 INFO - TEST-INFO | started process 13403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTGH5N9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:43 INFO - PID 13403 | 01:09:43 INFO - PID 13403 | (/builds/slave/test/build/application/firefox/firefox:13452): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:09:43 INFO - PID 13403 | 01:09:53 INFO - PID 13403 | RSS: Main: 170799104 01:09:53 INFO - PID 13403 | 01:12:52 INFO - PID 13403 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48689/tests/dromaeo/cssquery-ext.html) 01:12:53 INFO - PID 13403 | RSS: Main: 172769280 01:12:53 INFO - PID 13403 | 01:15:55 INFO - PID 13403 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-ext.html (next: http://localhost:48689/tests/dromaeo/cssquery-jquery.html) 01:15:56 INFO - PID 13403 | RSS: Main: 170156032 01:15:56 INFO - PID 13403 | 01:18:58 INFO - PID 13403 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48689/tests/dromaeo/cssquery-mootools.html) 01:18:58 INFO - PID 13403 | RSS: Main: 172023808 01:18:58 INFO - PID 13403 | 01:22:00 INFO - PID 13403 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48689/tests/dromaeo/cssquery-prototype.html) 01:22:01 INFO - PID 13403 | RSS: Main: 170549248 01:22:01 INFO - PID 13403 | 01:25:04 INFO - PID 13403 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48689/tests/dromaeo/cssquery-yui.html) 01:25:05 INFO - PID 13403 | RSS: Main: 171888640 01:25:05 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-yui.html (next: http://localhost:48689/tests/dromaeo/cssquery-dojo.html) 01:28:07 INFO - PID 13403 | RSS: Main: 174039040 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | __start_tp_report 01:28:07 INFO - PID 13403 | _x_x_mozilla_page_load 01:28:07 INFO - PID 13403 | _x_x_mozilla_page_load_details 01:28:07 INFO - PID 13403 | |i|pagename|runs| 01:28:07 INFO - PID 13403 | |0;dojo.html;3156.2740569668977;3172.77790554661;3191.2341038150844;3207.7273431758313;3212.726918211951;6220.968895155518;6282.183316168897;6340.809775706724;6362.650054247015;6391.552591318604;6163.938360616393;6254.655993920333;6305.148804911336;6332.176817013793;6339.01745229489;5664.660120392779;5733.254676891998;5750.453706897838;5765.625234359753;5788.768449262025;5755.107958266454;5825.592208545403;5833.970830145865;5845.0647896336595;5849.941500584982;69.48957860702009;5694.601377903548;5742.655440673573;5761.193432919353;5821.8835623287505;5661.547076233891;5665.915011274793;5755.30936287644;5758.971205143947;5763.567732420085;5663.1505274208785;5664.518515926151;5757.280339957505;5766.365699773021;5776.960147173507;6115.663638499881;6147.231596050494;6160.722767475474;6236.43872051513;6245.313015568284;6636.800895973129;6639.070530125786;6640.136782218329;6741.393274605309;6747.359000894956;6736.5958042517605;6760.32396760325;6831.487638427137;6834.897476537856;6846.623435711034;6223.097650840648;6254.405831446005;6310.148130002437;6325.051242313643;6342.873142537123;6937.861242775116;7015.824604384829;7027.824304392431;7036.155661320674;7050.294970502909;6649.135612370361;6690.297518760557;6710.865782684319;6725.05849181115;6734.797956061326;6733.42765864907;6749.595024298558;6757.256701762803;6835.58986460814;6846.828829279308;6598.307177746267;6667.066610674509;6671.39957403836;6694.163229596301;6827.317268273232;6670.794922245665;6747.831304217434;6768.932310676929;6772.085768421299;6774.288699686561;5428.945710542923;5429.53848922846;5430.755615997289;5431.891362172734;5437.728113594305;4622.399088118523;4684.414448193976;4701.905961880743;4713.74074425903;4727.338172655831;5763.682997435181;5768.971155144198;5853.1220316952795;5867;5871.970640146772;6645.269020407752;6724.226713927863;6744.966275168593;6794.150731158606;6815.420689241371;5803.216565763652;5821.621594596338;5821.650700957956;5828.154917536934;5828.388019257917;5896.233489646319;5901.40985901415;5903.852403689856;5917.31950825652;5924.644521328734;6488.026795980546;6538;6550.443212326911;6573.441257493071;6574.3754343337305;5867.618604790675;6718.697658605277;6745.696443659949;6836;6854.971754236904;6485.772997945238;6527.51043671717;6590;6596.769113081019;6599.175103112111;6531.738730450728;6601.768938087144;6617.636030018202;6625.105610742681;6638.17022872141;6705.366075939398;6718.798436046926;6806.319368063352;6813.250542440427;6813.250542440427;6521.184851893513;6557.704903279268;6562.704678289393;6575.210974683068;6681.498887583353;6504.414602685781;6504.4796416285635;6578.440832529097;6603.867922641424;6633.1045308882685;6403.231612206565;6511.544191906711;6511.576747511396;6513.348665133638;6519.967400162969;6569.967150164219;6592.80221593353;6609.3060228675295;6620.2386725527185;6685.164354455693;6257.78097766576;6367;6384.553081284265;6393.360663933569;6481.189851268591 01:28:07 INFO - PID 13403 | |1;ext.html;793.1394437035816;829.208106258523;854.2567965869692;1174.0666170394536;1197.4372045138782;31266.68733312666;42334;42935.57064429355;42937.35593966093;42944.78527607358;42789.14421711564;42959.57040429595;43005.13989720204;43266.783666081705;43271.35092973608;7857.2535609117185;7928.643211055516;7942.166072562384;8011.719589814357;8014.919850801476;7786.182450842636;7931.24653157952;7932.841343173162;7933.523988560676;7933.563653999027;7358.889616655754;7918.683252669886;7967.322777563914;7988.560629165394;8005.279524842763;7874.9212507875045;7891.723789667334;7895.131535531087;7933.880991785128;7940.841183176333;7564.546127232384;7710.884336734954;7769.145394006655;7811.882821757678;7893.447458677895;39056.414153787715;39574.60425395738;39588.80205598982;39817.60182398197;39865.40201896974;3412.4198886189406;3412.709919656832;3428.468587368962;3430.828458577061;3431.571053618273;32292.838535807405;32342.676573234436;32367;32449;32465.51301730476;4808.927866082012;4921.434035085975;4923.08922849274;4931.827386041471;4945.455999840015;194127;195712;198065;198517;198867;49414.50585494171;49931.750341248786;50107.74946125246;50500.74749626228;50552.494475055515;52602;52681.47318526842;52682.73658631759;52728.20907686388;52803.73598131985;16391.672166556604;16495.670086598202;16526;16530.66938661244;16532.173391330387;13347.399367028507;13378.531751388655;13392.330383480787;13394.464221431228;13475.865241347658;12656.746865062647;13902;14003.159810411407;14123;14173.78739318911;5024.196128619404;6017.578769486094;6038.154658347835;6202.596831205957;6305.936940630627;975.4001289207087;987.5111819649176;996.3374356053289;1023.7082431506984;1024.3546565663585;23087.19194828173;23263;23427.765722342898;23559.293221203392;23669.053237870638;1048.2190767877828;1102.0302134122082;1105.2429086076063;1113.1595645287755;1120.4117838135044;11794.846577498;12261.448234829453;15447.613809654624;15658.843411565738;16230.675386492205;215447;219981;232611;233411;236541;58169.709151454816;58419;58516.70741646265;58832.41167588355;58865.41134588685;1471.3452513631332;1475.3213521779887;1486.9405223791143;1490.135721281654;1502.609321576398;26113.73886261113;27009.86495067512;27116.1865144046;27135.45729085368;27298.727012729618;37474.8126259367;38026.61973380342;38027.2394552113;38345.80827095846;38371.23257534778;203357;203757;205272;205453;205730;32668.83665581657;32731.836340818143;33259.16852078717;37047.444288336235;38164;41581;42499;48173.75913120412;48338.75830620824;49323;31631.683683163796;33329.66703329648;33909.152271193416;34559.13602159966;35026.64973350336;32804.507932380555;33583.66416335805;33871.66128338784;33918.83040584781;34147.4877876837;36499.1795256343;37528.2494350106;38348.424773628976;38780.61219387883;38799;31311.37377252488;32923.17692057718;33908.321833563685;34148.82925585456;34318.828405857814;23842.88078559596;25033.12384066549;25465.363365916;25632.87183564145;25719 01:28:07 INFO - PID 13403 | |2;jquery.html;574.6523353371213;580.747374891922;582.947534721875;583.646893629354;603.5232166588395;22029.889850550746;22518.43703907403;23085.538289234228;23197.18809841656;23209.535809283825;24397.75602243977;25127;25168;25313.493730125385;25351.492970140585;6527;6639.900401493981;6697.564658297195;6702.597844129368;6703.128593282866;6007.4593286604195;6555.508336874754;6574.211094668646;6577.276499585066;6590.275069742324;6555.737770489175;6559.245686746038;6560.081588577603;6564.967175164117;6568.671566421684;6488.740450381979;6541.836454088662;6556.082148499214;6579.210494740638;6582.17722784652;6060.666663333515;6096.664683442409;6098.756049758004;6100.359462256443;6101.633901965896;28373.14880553566;28604.856975715196;28908.132756017352;30114.84942575295;30148;1850.2044121027952;1886.6509695706338;1901.7432646592672;1901.9809801902081;1902.7526421565108;18718;18779;19300.1314940828;19352.70970935437;19950.201991920305;2265.184533567914;2304.320225533472;2328.7671232876746;2337.2988103569032;2344.15610380263;129875;131980;132040.33979830134;132198.3390083053;132426;14011.229382383863;14881.627959300888;15006.099634021994;15153.242337883063;15235;23389.064437422312;23451.296461106194;23490.64764028541;23574.646380304308;23590.17434389788;10039.548220330104;10079.193664506822;10361.689149325532;10371.066604005675;10410.271281010257;7561.508501947355;7977.162397948248;9341.532923353805;9455.952720236355;9483.33616646842;10830.783384332426;11272.323660580392;11302.265352752209;11338.206325557298;11780.587679431179;3902.31709450845;4201.894952626148;4224.831006759695;4273.337632666941;4398.164348773723;903;943.8725772020827;949.2548349545712;973.3089506450499;986.4328011393477;18825.30572248504;19505.707414388795;19696.40910772679;19811.405657830288;19981.400557983285;1010.8736407949007;1013.9340942838692;1019.4291196929743;1043.4313299251926;1049.6693541534546;10776.353418794897;13137.934310328386;13236.867631323756;14052.36764345607;14235.43058277678;447620;465285;471895;476919;488881;113603;116468;116763;117950;118430.40784796193;1239.5599562155485;1271.771081205392;1296.0538806671184;1298.2016060123144;1307.9542216022394;19801.900990494956;20761.89619051895;21296.680549792076;21337;21352.252671156435;53094;53197.4680253208;53848.73075634597;54476.455235448724;55649.165262520284;66412;66739.66630166819;67287.66356168188;67463.32536674767;67972;14332.641683957985;14387.92806036005;15111.168885710951;15245.542633721006;15300.923495382453;24552.140675076287;24610.384740381633;24752.25743227706;24860;25011.624825627267;18868.811311886704;19062.618747624692;19394.224231031167;19405.4178374649;19444.319448819224;16956.15219239058;17285.567860803076;17425.73861392055;17736.911315443856;17770.378036768652;20038.098285576893;20278.188872444938;20436.69344959797;20511;20518.794812052285;14384.352704128549;14403.495877644233;14804;14860.925695371454;14917.104973701613;19564.510887227934;19597.31409400664;19652;19753;19787.50531236673 01:28:07 INFO - PID 13403 | |3;mootools.html;1327.5950834995326;1365.6790654196266;1379.5309594737794;1390.9582712518622;1396.7555677756402;13749.65625859354;14292.142471451694;14305.141691498491;14309.713805723879;14310.21293828839;13444.865551344483;13942.302884855742;14425.278736063206;14426.927865360658;14447.927760361183;2592.64999225105;2633.4074833162576;2635;2636.393629465224;2638.986805065972;2541.682289713786;2593.5201987632254;2645.986770066147;2650.615660729193;2651.138380026499;2659.321872922412;2666.8666566671686;2680.6917204521437;2681.5977603359556;2689.2066840282064;2578.2136448383235;2588.3270349709023;2604.3619313268277;2606.3744701271557;2607.778338841201;2554.3741783263035;2563.6026415905562;2571.434284457416;2573.1765834932644;2573.318070711263;13710.314484275847;13820.723585528334;13834.031617786759;13840.169589824542;13846.446142154302;7522.473426860067;7773.183815699326;7801.375889928849;7809.140994490602;7817.570033648147;4758.119747846659;4962.702237865739;5037.29477873098;5057.9494205057845;5067.442581316052;1793.7937137229126;1830.670479313723;1841.539615096226;1857.2849452960572;1887.867849250553;22859.885700571558;22972.310830675106;22988.310350689506;22989.54020919589;23067.423314417105;6418.101465794793;6486.124373209556;6496.675166241669;6594.241662208811;6667.966660166765;15710.135942523042;15772.211389430482;15814.130222837624;15834.683306333809;15899.364025438854;7463.8507229855095;7602.42981776369;7651.846963060819;7658.042744656918;7669.5398276103615;6892.276310987374;6896.620685862225;7026;7046.92953070473;7105.644717764091;4530.796114174804;4767.141914455362;4926;4954.133026720309;4982.800687972513;1344.2270694350786;1482.2588705647177;1496.6707324388617;1508.0725353907487;1518.468536012409;842.4103127810557;847.6694089305176;852.2329903087272;854.4189950833493;883.8055627761883;7325.2674732527385;7469.85060298791;7591.202923693043;7734.458587898793;7790.415718821111;918.8943271523726;922.8707980882682;947.393668052447;959.6641175588628;990.3067852503276;3959.604039596017;4443.4445694288215;4791.664583479123;4823.879403014953;4843.75781210938;18073.367432140076;18643.720344194848;18762.155702993397;18775.718364224547;18776;18148.546286342684;18596.907015464836;19610.313639022566;19642.214311427382;19730.70403943942;10762.784744305227;11006.889931100906;11031.172662050218;11065.557377704963;11099.223054386115;6980.860382792214;7335.523190992569;7390.150132734804;7484.101907771103;7549.622518874145;16492.42276520316;16688.415905443253;16775.412860549823;16825.495235142964;17580.120993950506;16543.503694889172;17250.65498690044;17344.132793360535;17463.82536174622;17600.823991759917;11058.502367393326;11350.375729334966;11351.659450216506;11351.716207094889;11356.943215284202;12635.747285054063;12887.09790314669;12927.353632318158;12983.221006739626;13019.869801302244;10032.147267482345;10583.94708026455;10619.840702389316;10731.839022414513;10909.727256818325;10325.535350909076;10444.112250458797;10463.895361046292;10991.890081099087;11002.449877506253;8819.867701984604;8832.425892316978;8923.955380223057;8924.86612700823;8938.910610894069;6483.351664833479;6797.626130562867;6872.072270243653;6886.10480637514;6951.965240173767;6679.398854103154;6715.227748808949;6774.458043356618;6883.552569082994;6946.687399067156 01:28:07 INFO - PID 13403 | |4;prototype.html;495.0617589544295;507.55588859747724;522.1306524636481;529.7271904968942;531.3199105145416;6253.843653908654;6286.528510361724;6293.0737207198645;6304.558680892339;6315.968420157898;5938.228030356058;6010.6093103948215;6055.545834062441;6060.636361818294;6118.632882027082;4882.048000639877;4883.706977581339;4896.755162241891;4924.655274130812;4927.975360123212;4770.713757174563;4874.488178741234;4887.462379138292;4892.535209155125;4928.137575924216;4943.406791185045;5011.699298042111;5039.3196918415915;5044;5079.4412614612365;5005.599552035828;5063.569596584295;5088.974555127201;5096.592272618182;5130.179171332569;4713.976430117862;4729.574338309534;4731.1720448921305;4785.396892041171;4788.162071637485;5925.31858836235;5998.490128339096;6041.5468839837185;6052.182955301022;6077.726502307407;5783.21926539916;5791.305043394819;5835.562332825055;5891.3814049525035;5906.704664766788;6410.358964103552;6473.676316184172;6480.222373315232;6510.772122975721;6550.886349320579;5131.820386286462;5139.820106296262;5214.608904332153;5222.712750798704;5227.947720522822;6889.276625954253;6897.48268879841;6899.275576064491;6940.41006514452;6941.5140940134215;5272.367315922113;5294.57643388528;5329.920051199235;5380.677159370451;5387.9461205388225;5376;5425.348958125051;5448.645838020516;5471.753771080232;5472.370677372073;5839.773647533981;5866.882662346729;5875.206847075676;5887.646741195542;5931.73307201177;6443.7744678936015;6490.2536208335705;6537.836554086186;6567.868642627121;6644.468442524587;1822.963540729178;1865.9008615307778;1874.4845167578753;1894.8768330058501;1931.5460866696314;1359.8776110150134;1395.4976208564908;1449.6375906023495;1455.2432734977751;1460.072853737863;5581;5700.37295897451;5748.166515855178;5750.741216645261;5763.106718458645;6488.675566221765;6514.850099467165;6588.604683718896;6596.340365963365;6600.570962887493;5722.227499287626;5726.9713651431475;5730.36965933747;5746;5766.481016708516;3511.8595256189465;3518.5222206673257;3549.254656522159;3550.396432606463;3551.183227857607;6385.233771947396;6424.196975378078;6450.354964503512;6517.3808488193545;6566.8358291043105;6862.622555759481;6873.4157596603845;6918.688659010357;6925.757598484029;6971.163460384685;6534.444572211415;6551.6069035858;6563.540552161398;6574.192097173315;6580.901286480611;6750.831229219112;6755.3582409671;6759.5606285591275;6760.425363844129;6772.762953296611;6616.470682345497;6627.635480048643;6638.468922486286;6679.76620818269;6726.495512836655;6344.841378965562;6378.617282963037;6493.2857385688485;6505.804825855232;6534.673266336759;4823.782929768239;4905.9018819624125;4915.164422048332;4919.581835544019;4926.211806111005;6733.478547590928;6764.763233287008;6784.932150678627;6837.829054273484;6838.14523184602;6377.904331434939;6414.294427613052;6468.450181734605;6477.546571739933;6547.181602299713;6386.840328991812;6416.711247993758;6470.7088181032905;6521.739130434729;6530.771423000172;6117.357677443804;6387.233531976192;6410.679466026773;6460.515461340325;6493.116996071087;6379.553431259767;6520.836979075561;6524.217093948567;6547.214334279726;6552.803415897531;6295.905561416491;6296.433321000949;6321.96839015802;6323.588966717149;6334.6832658365975 01:28:07 INFO - PID 13403 | |5;yui.html;905.1265528764741;916.1891725822647;923.4044041593172;926.305271046715;926.3654396738231;17879.19543620537;18851.340203092877;18887.15007824648;18909.338173163942;20239.59520809583;19915.004249787526;21018.894905525452;21184.57630847382;21274.680879786778;21289;1051.4690081508847;1070.288258308228;1076.4994277660885;1077.5905156040694;1078.2937176149635;1059.8781140168903;1063.4363787192801;1064.2603390643505;1064.7551063255455;1065.4619417194306;1073.425717241276;1119.0655802405001;1125.6397952655154;1128.401946968104;1129.3619105205573;1110.3393480878945;1114.7380365614074;1118.2675347647305;1118.35694475676;1120.8710998235185;798.0104670208957;798.8522123407188;799.2167675677811;802.7952872017656;803.8553060449117;18485;19121.23515059396;19301.61396772057;19373.61252774951;19448.4165475036;19814.80185198144;20137.597248055103;20164.19343226269;20302.492437689176;20313;15351.309191086428;15353.15557644329;15605.765913511306;15620.297086631128;15673.843261567352;3443.3974054540604;3482.0424383294544;3482.860685572574;3494.5631796025496;3499.6500349965054;118223;118391;121476.39261803722;123830;123922.38038809749;15641.217939102999;15824.129672867872;15993.28030238642;16004.03975761458;16034.278457469441;29644.407111857643;29731;29754.553681694793;29790;29868.40263194724;7611.771646850603;8187.549684767276;8281.089080201173;8645.654173833102;8702.260307873776;3984.3425834737523;4248.129133527619;4259.7231179973205;4267.594578515036;4271.060366719316;4899.020195960751;4957.206846904478;5021.447640759514;5026.220935754964;5101.795928162832;1025.8409946458312;1049.7742985258205;1069.0645685025602;1070.1171533484905;1073.7906108308962;660.3825423229296;668.2815972829228;675.5074847595987;703.9859202815915;707.7912015955305;10761.569537218424;11218.214724969173;11416.42917854104;11497.310161390344;11971.74296698834;633.8383712153371;636.1888592045087;645.2257291250518;649.8797722421367;650.6844180572418;5129.615278854101;5142.305788718475;5199.688018718889;5338.119210330252;5370.301860758076;97884;101663.49168254112;104872.47563762132;106046;108284.45857770661;87898;91061;91394.54302728444;92659;95258;79779;80172;80936.59531702304;83050.16949830545;83345.58327208325;11076;11160.162987775788;11361.659150225507;11594.5362185515;12106.939465302617;32603.34793304168;33877;34017.14957126092;35383;35712.28575428425;42374.788126059175;61841.69079154755;62203.377966219756;62822;66191.00713489205;15490.9225453872;15562.922185389001;15629.609259768142;15688.529344119695;16911.238994245534;15963.042217466525;16712.582185444975;17000.829991699924;17077.573060673087;18640.627187456445;16635;16766.66466670684;17383.47849564515;17623.735643965607;17833.554161146076;16334.346626134822;16500.17499125063;16582.917085414494;16643.251053702854;16709.415170469463;17338.393156239974;17688.027158506407;17918.820811791717;17943.282268709107;17966.371177009263;12519.54168563149;12880.806787898002;12991.090623656253;13201.60395188146;13813.240271784747;12133.514659413524;12397.512298524234;12751.553695620609;12960.805587916377;13454.663633409244 01:28:07 INFO - PID 13403 | __end_tp_report 01:28:07 INFO - PID 13403 | __start_cc_report 01:28:07 INFO - PID 13403 | _x_x_mozilla_cycle_collect,363 01:28:07 INFO - PID 13403 | __end_cc_report 01:28:07 INFO - PID 13403 | __startTimestamp1501230487547__endTimestamp 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | ------- Summary: start ------- 01:28:07 INFO - PID 13403 | Number of tests: 6 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | [#0] dojo.html Cycles:165 Average:6164.87 Median:6488.03 stddev:875.53 (13.5%) stddev-sans-first:845.81 01:28:07 INFO - PID 13403 | Values: 3156.3 3172.8 3191.2 3207.7 3212.7 6221.0 6282.2 6340.8 6362.7 6391.6 6163.9 6254.7 6305.1 6332.2 6339.0 5664.7 5733.3 5750.5 5765.6 5788.8 5755.1 5825.6 5834.0 5845.1 5849.9 69.5 5694.6 5742.7 5761.2 5821.9 5661.5 5665.9 5755.3 5759.0 5763.6 5663.2 5664.5 5757.3 5766.4 5777.0 6115.7 6147.2 6160.7 6236.4 6245.3 6636.8 6639.1 6640.1 6741.4 6747.4 6736.6 6760.3 6831.5 6834.9 6846.6 6223.1 6254.4 6310.1 6325.1 6342.9 6937.9 7015.8 7027.8 7036.2 7050.3 6649.1 6690.3 6710.9 6725.1 6734.8 6733.4 6749.6 6757.3 6835.6 6846.8 6598.3 6667.1 6671.4 6694.2 6827.3 6670.8 6747.8 6768.9 6772.1 6774.3 5428.9 5429.5 5430.8 5431.9 5437.7 4622.4 4684.4 4701.9 4713.7 4727.3 5763.7 5769.0 5853.1 5867.0 5872.0 6645.3 6724.2 6745.0 6794.2 6815.4 5803.2 5821.6 5821.7 5828.2 5828.4 5896.2 5901.4 5903.9 5917.3 5924.6 6488.0 6538.0 6550.4 6573.4 6574.4 5867.6 6718.7 6745.7 6836.0 6855.0 6485.8 6527.5 6590.0 6596.8 6599.2 6531.7 6601.8 6617.6 6625.1 6638.2 6705.4 6718.8 6806.3 6813.3 6813.3 6521.2 6557.7 6562.7 6575.2 6681.5 6504.4 6504.5 6578.4 6603.9 6633.1 6403.2 6511.5 6511.6 6513.3 6520.0 6570.0 6592.8 6609.3 6620.2 6685.2 6257.8 6367.0 6384.6 6393.4 6481.2 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | [#1] ext.html Cycles:180 Average:38758.12 Median:34438.98 stddev:54448.94 (158.1%) stddev-sans-first:54527.05 01:28:07 INFO - PID 13403 | Values: 793.1 829.2 854.3 1174.1 1197.4 31266.7 42334.0 42935.6 42937.4 42944.8 42789.1 42959.6 43005.1 43266.8 43271.4 7857.3 7928.6 7942.2 8011.7 8014.9 7786.2 7931.2 7932.8 7933.5 7933.6 7358.9 7918.7 7967.3 7988.6 8005.3 7874.9 7891.7 7895.1 7933.9 7940.8 7564.5 7710.9 7769.1 7811.9 7893.4 39056.4 39574.6 39588.8 39817.6 39865.4 3412.4 3412.7 3428.5 3430.8 3431.6 32292.8 32342.7 32367.0 32449.0 32465.5 4808.9 4921.4 4923.1 4931.8 4945.5 194127.0 195712.0 198065.0 198517.0 198867.0 49414.5 49931.8 50107.7 50500.7 50552.5 52602.0 52681.5 52682.7 52728.2 52803.7 16391.7 16495.7 16526.0 16530.7 16532.2 13347.4 13378.5 13392.3 13394.5 13475.9 12656.7 13902.0 14003.2 14123.0 14173.8 5024.2 6017.6 6038.2 6202.6 6305.9 975.4 987.5 996.3 1023.7 1024.4 23087.2 23263.0 23427.8 23559.3 23669.1 1048.2 1102.0 1105.2 1113.2 1120.4 11794.8 12261.4 15447.6 15658.8 16230.7 215447.0 219981.0 232611.0 233411.0 236541.0 58169.7 58419.0 58516.7 58832.4 58865.4 1471.3 1475.3 1486.9 1490.1 1502.6 26113.7 27009.9 27116.2 27135.5 27298.7 37474.8 38026.6 38027.2 38345.8 38371.2 203357.0 203757.0 205272.0 205453.0 205730.0 32668.8 32731.8 33259.2 37047.4 38164.0 41581.0 42499.0 48173.8 48338.8 49323.0 31631.7 33329.7 33909.2 34559.1 35026.6 32804.5 33583.7 33871.7 33918.8 34147.5 36499.2 37528.2 38348.4 38780.6 38799.0 31311.4 32923.2 33908.3 34148.8 34318.8 23842.9 25033.1 25465.4 25632.9 25719.0 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | [#2] jquery.html Cycles:180 Average:34273.26 Median:22274.16 stddev:79192.43 (355.5%) stddev-sans-first:79374.17 01:28:07 INFO - PID 13403 | Values: 574.7 580.7 582.9 583.6 603.5 22029.9 22518.4 23085.5 23197.2 23209.5 24397.8 25127.0 25168.0 25313.5 25351.5 6527.0 6639.9 6697.6 6702.6 6703.1 6007.5 6555.5 6574.2 6577.3 6590.3 6555.7 6559.2 6560.1 6565.0 6568.7 6488.7 6541.8 6556.1 6579.2 6582.2 6060.7 6096.7 6098.8 6100.4 6101.6 28373.1 28604.9 28908.1 30114.8 30148.0 1850.2 1886.7 1901.7 1902.0 1902.8 18718.0 18779.0 19300.1 19352.7 19950.2 2265.2 2304.3 2328.8 2337.3 2344.2 129875.0 131980.0 132040.3 132198.3 132426.0 14011.2 14881.6 15006.1 15153.2 15235.0 23389.1 23451.3 23490.6 23574.6 23590.2 10039.5 10079.2 10361.7 10371.1 10410.3 7561.5 7977.2 9341.5 9456.0 9483.3 10830.8 11272.3 11302.3 11338.2 11780.6 3902.3 4201.9 4224.8 4273.3 4398.2 903.0 943.9 949.3 973.3 986.4 18825.3 19505.7 19696.4 19811.4 19981.4 1010.9 1013.9 1019.4 1043.4 1049.7 10776.4 13137.9 13236.9 14052.4 14235.4 447620.0 465285.0 471895.0 476919.0 488881.0 113603.0 116468.0 116763.0 117950.0 118430.4 1239.6 1271.8 1296.1 1298.2 1308.0 19801.9 20761.9 21296.7 21337.0 21352.3 53094.0 53197.5 53848.7 54476.5 55649.2 66412.0 66739.7 67287.7 67463.3 67972.0 14332.6 14387.9 15111.2 15245.5 15300.9 24552.1 24610.4 24752.3 24860.0 25011.6 18868.8 19062.6 19394.2 19405.4 19444.3 16956.2 17285.6 17425.7 17736.9 17770.4 20038.1 20278.2 20436.7 20511.0 20518.8 14384.4 14403.5 14804.0 14860.9 14917.1 19564.5 19597.3 19652.0 19753.0 19787.5 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | [#3] mootools.html Cycles:180 Average:8595.44 Median:2575.77 stddev:5910.55 (229.5%) stddev-sans-first:5901.90 01:28:07 INFO - PID 13403 | Values: 1327.6 1365.7 1379.5 1391.0 1396.8 13749.7 14292.1 14305.1 14309.7 14310.2 13444.9 13942.3 14425.3 14426.9 14447.9 2592.6 2633.4 2635.0 2636.4 2639.0 2541.7 2593.5 2646.0 2650.6 2651.1 2659.3 2666.9 2680.7 2681.6 2689.2 2578.2 2588.3 2604.4 2606.4 2607.8 2554.4 2563.6 2571.4 2573.2 2573.3 13710.3 13820.7 13834.0 13840.2 13846.4 7522.5 7773.2 7801.4 7809.1 7817.6 4758.1 4962.7 5037.3 5057.9 5067.4 1793.8 1830.7 1841.5 1857.3 1887.9 22859.9 22972.3 22988.3 22989.5 23067.4 6418.1 6486.1 6496.7 6594.2 6668.0 15710.1 15772.2 15814.1 15834.7 15899.4 7463.9 7602.4 7651.8 7658.0 7669.5 6892.3 6896.6 7026.0 7046.9 7105.6 4530.8 4767.1 4926.0 4954.1 4982.8 1344.2 1482.3 1496.7 1508.1 1518.5 842.4 847.7 852.2 854.4 883.8 7325.3 7469.9 7591.2 7734.5 7790.4 918.9 922.9 947.4 959.7 990.3 3959.6 4443.4 4791.7 4823.9 4843.8 18073.4 18643.7 18762.2 18775.7 18776.0 18148.5 18596.9 19610.3 19642.2 19730.7 10762.8 11006.9 11031.2 11065.6 11099.2 6980.9 7335.5 7390.2 7484.1 7549.6 16492.4 16688.4 16775.4 16825.5 17580.1 16543.5 17250.7 17344.1 17463.8 17600.8 11058.5 11350.4 11351.7 11351.7 11356.9 12635.7 12887.1 12927.4 12983.2 13019.9 10032.1 10583.9 10619.8 10731.8 10909.7 10325.5 10444.1 10463.9 10991.9 11002.4 8819.9 8832.4 8924.0 8924.9 8938.9 6483.4 6797.6 6872.1 6886.1 6952.0 6679.4 6715.2 6774.5 6883.6 6946.7 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | [#4] prototype.html Cycles:180 Average:5543.40 Median:6053.86 stddev:1506.00 (24.9%) stddev-sans-first:1461.78 01:28:07 INFO - PID 13403 | Values: 495.1 507.6 522.1 529.7 531.3 6253.8 6286.5 6293.1 6304.6 6316.0 5938.2 6010.6 6055.5 6060.6 6118.6 4882.0 4883.7 4896.8 4924.7 4928.0 4770.7 4874.5 4887.5 4892.5 4928.1 4943.4 5011.7 5039.3 5044.0 5079.4 5005.6 5063.6 5089.0 5096.6 5130.2 4714.0 4729.6 4731.2 4785.4 4788.2 5925.3 5998.5 6041.5 6052.2 6077.7 5783.2 5791.3 5835.6 5891.4 5906.7 6410.4 6473.7 6480.2 6510.8 6550.9 5131.8 5139.8 5214.6 5222.7 5227.9 6889.3 6897.5 6899.3 6940.4 6941.5 5272.4 5294.6 5329.9 5380.7 5387.9 5376.0 5425.3 5448.6 5471.8 5472.4 5839.8 5866.9 5875.2 5887.6 5931.7 6443.8 6490.3 6537.8 6567.9 6644.5 1823.0 1865.9 1874.5 1894.9 1931.5 1359.9 1395.5 1449.6 1455.2 1460.1 5581.0 5700.4 5748.2 5750.7 5763.1 6488.7 6514.9 6588.6 6596.3 6600.6 5722.2 5727.0 5730.4 5746.0 5766.5 3511.9 3518.5 3549.3 3550.4 3551.2 6385.2 6424.2 6450.4 6517.4 6566.8 6862.6 6873.4 6918.7 6925.8 6971.2 6534.4 6551.6 6563.5 6574.2 6580.9 6750.8 6755.4 6759.6 6760.4 6772.8 6616.5 6627.6 6638.5 6679.8 6726.5 6344.8 6378.6 6493.3 6505.8 6534.7 4823.8 4905.9 4915.2 4919.6 4926.2 6733.5 6764.8 6784.9 6837.8 6838.1 6377.9 6414.3 6468.5 6477.5 6547.2 6386.8 6416.7 6470.7 6521.7 6530.8 6117.4 6387.2 6410.7 6460.5 6493.1 6379.6 6520.8 6524.2 6547.2 6552.8 6295.9 6296.4 6322.0 6323.6 6334.7 01:28:07 INFO - PID 13403 | 01:28:07 INFO - PID 13403 | [#5] yui.html Cycles:180 Average:22212.14 Median:18745.98 stddev:30188.33 (161.0%) stddev-sans-first:30230.62 01:28:07 INFO - PID 13403 | Values: 905.1 916.2 923.4 926.3 926.4 17879.2 18851.3 18887.2 18909.3 20239.6 19915.0 21018.9 21184.6 21274.7 21289.0 1051.5 1070.3 1076.5 1077.6 1078.3 1059.9 1063.4 1064.3 1064.8 1065.5 1073.4 1119.1 1125.6 1128.4 1129.4 1110.3 1114.7 1118.3 1118.4 1120.9 798.0 798.9 799.2 802.8 803.9 18485.0 19121.2 19301.6 19373.6 19448.4 19814.8 20137.6 20164.2 20302.5 20313.0 15351.3 15353.2 15605.8 15620.3 15673.8 3443.4 3482.0 3482.9 3494.6 3499.7 118223.0 118391.0 121476.4 123830.0 123922.4 15641.2 15824.1 15993.3 16004.0 16034.3 29644.4 29731.0 29754.6 29790.0 29868.4 7611.8 8187.5 8281.1 8645.7 8702.3 3984.3 4248.1 4259.7 4267.6 4271.1 4899.0 4957.2 5021.4 5026.2 5101.8 1025.8 1049.8 1069.1 1070.1 1073.8 660.4 668.3 675.5 704.0 707.8 10761.6 11218.2 11416.4 11497.3 11971.7 633.8 636.2 645.2 649.9 650.7 5129.6 5142.3 5199.7 5338.1 5370.3 97884.0 101663.5 104872.5 106046.0 108284.5 87898.0 91061.0 91394.5 92659.0 95258.0 79779.0 80172.0 80936.6 83050.2 83345.6 11076.0 11160.2 11361.7 11594.5 12106.9 32603.3 33877.0 34017.1 35383.0 35712.3 42374.8 61841.7 62203.4 62822.0 66191.0 15490.9 15562.9 15629.6 15688.5 16911.2 15963.0 16712.6 17000.8 17077.6 18640.6 16635.0 16766.7 17383.5 17623.7 17833.6 16334.3 16500.2 16582.9 16643.3 16709.4 17338.4 17688.0 17918.8 17943.3 17966.4 12519.5 12880.8 12991.1 13201.6 13813.2 12133.5 12397.5 12751.6 12960.8 13454.7 01:28:07 INFO - PID 13403 | -------- Summary: end -------- 01:28:07 INFO - PID 13403 | 01:28:08 INFO - TEST-INFO | 13403: exit 0 01:28:08 INFO - TEST-OK | dromaeo_css | took 1111915ms 01:28:08 INFO - TEST-START | kraken 01:28:08 INFO - Initialising browser for kraken test... 01:28:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48689/getInfo.html -profile /tmp/tmpEczwTg/profile 01:28:08 INFO - TEST-INFO | started process 13767 (/builds/slave/test/build/application/firefox/firefox http://localhost:48689/getInfo.html) 01:28:13 INFO - TEST-INFO | 13767: exit 0 01:28:14 INFO - Browser initialized. 01:28:14 INFO - Running cycle 1/1 for kraken test... 01:28:14 INFO - TEST-INFO | started process 13974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEczwTg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:15 INFO - PID 13974 | 01:28:15 INFO - PID 13974 | (/builds/slave/test/build/application/firefox/firefox:14022): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:28:15 INFO - PID 13974 | 01:28:25 INFO - PID 13974 | RSS: Main: 171012096 01:28:25 INFO - PID 13974 | 01:28:28 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:29 INFO - PID 13974 | RSS: Main: 177291264 01:28:29 INFO - PID 13974 | 01:28:31 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-dft) 01:28:32 INFO - PID 13974 | RSS: Main: 177418240 01:28:32 INFO - PID 13974 | 01:28:35 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-fft) 01:28:35 INFO - PID 13974 | RSS: Main: 171061248 01:28:35 INFO - PID 13974 | 01:28:38 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-oscillator) 01:28:38 INFO - PID 13974 | RSS: Main: 171720704 01:28:38 INFO - PID 13974 | 01:28:40 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:41 INFO - PID 13974 | RSS: Main: 171823104 01:28:41 INFO - PID 13974 | 01:28:44 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:45 INFO - PID 13974 | RSS: Main: 174936064 01:28:45 INFO - PID 13974 | 01:28:48 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:49 INFO - PID 13974 | RSS: Main: 174845952 01:28:49 INFO - PID 13974 | 01:28:52 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48689/tests/kraken/driver.html?testName=json-parse-financial) 01:28:52 INFO - PID 13974 | RSS: Main: 175153152 01:28:52 INFO - PID 13974 | 01:28:54 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:28:54 INFO - PID 13974 | RSS: Main: 175079424 01:28:54 INFO - PID 13974 | 01:28:56 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:28:57 INFO - PID 13974 | RSS: Main: 175177728 01:28:57 INFO - PID 13974 | 01:28:59 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:00 INFO - PID 13974 | RSS: Main: 172662784 01:29:00 INFO - PID 13974 | 01:29:02 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:03 INFO - PID 13974 | RSS: Main: 172646400 01:29:03 INFO - PID 13974 | 01:29:06 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:07 INFO - PID 13974 | RSS: Main: 172859392 01:29:07 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48689/tests/kraken/driver.html?testName=ai-astar) 01:29:09 INFO - PID 13974 | RSS: Main: 174424064 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | __start_tp_report 01:29:09 INFO - PID 13974 | _x_x_mozilla_page_load 01:29:09 INFO - PID 13974 | _x_x_mozilla_page_load_details 01:29:09 INFO - PID 13974 | |i|pagename|runs| 01:29:09 INFO - PID 13974 | |0;ai-astar;101;107;104;109;110;111;110;102;111;112 01:29:09 INFO - PID 13974 | |1;audio-beat-detection;148;118;147;173;119;143;151;121;172;119 01:29:09 INFO - PID 13974 | |2;audio-dft;165;164;163;165;161;163;166;170;162;165 01:29:09 INFO - PID 13974 | |3;audio-fft;76;74;75;165;77;76;77;76;148;77 01:29:09 INFO - PID 13974 | |4;audio-oscillator;79;78;132;79;79;79;137;79;79;131 01:29:09 INFO - PID 13974 | |5;imaging-gaussian-blur;113;114;114;114;114;114;116;114;114;114 01:29:09 INFO - PID 13974 | |6;imaging-darkroom;150;152;151;151;152;151;150;152;151;150 01:29:09 INFO - PID 13974 | |7;imaging-desaturate;94;95;104;94;102;94;94;95;94;94 01:29:09 INFO - PID 13974 | |8;json-parse-financial;57;58;57;57;57;57;57;64;57;59 01:29:09 INFO - PID 13974 | |9;json-stringify-tinderbox;54;54;54;55;54;53;54;67;54;60 01:29:09 INFO - PID 13974 | |10;stanford-crypto-aes;80;99;81;90;81;99;80;80;79;79 01:29:09 INFO - PID 13974 | |11;stanford-crypto-ccm;135;132;132;126;130;129;124;139;128;172 01:29:09 INFO - PID 13974 | |12;stanford-crypto-pbkdf2;183;178;179;180;183;180;179;178;179;171 01:29:09 INFO - PID 13974 | |13;stanford-crypto-sha256-iterative;69;69;72;70;67;68;75;71;68;70 01:29:09 INFO - PID 13974 | __end_tp_report 01:29:09 INFO - PID 13974 | __start_cc_report 01:29:09 INFO - PID 13974 | _x_x_mozilla_cycle_collect,972 01:29:09 INFO - PID 13974 | __end_cc_report 01:29:09 INFO - PID 13974 | __startTimestamp1501230549446__endTimestamp 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | ------- Summary: start ------- 01:29:09 INFO - PID 13974 | Number of tests: 14 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:4.00 (3.6%) stddev-sans-first:3.43 01:29:09 INFO - PID 13974 | Values: 101.0 107.0 104.0 109.0 110.0 111.0 110.0 102.0 111.0 112.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:147.50 stddev:21.27 (14.4%) stddev-sans-first:22.41 01:29:09 INFO - PID 13974 | Values: 148.0 118.0 147.0 173.0 119.0 143.0 151.0 121.0 172.0 119.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.50 (1.5%) stddev-sans-first:2.65 01:29:09 INFO - PID 13974 | Values: 165.0 164.0 163.0 165.0 161.0 163.0 166.0 170.0 162.0 165.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:34.19 (45.0%) stddev-sans-first:35.76 01:29:09 INFO - PID 13974 | Values: 76.0 74.0 75.0 165.0 77.0 76.0 77.0 76.0 148.0 77.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:79.00 stddev:26.36 (33.4%) stddev-sans-first:27.30 01:29:09 INFO - PID 13974 | Values: 79.0 78.0 132.0 79.0 79.0 79.0 137.0 79.0 79.0 131.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 01:29:09 INFO - PID 13974 | Values: 113.0 114.0 114.0 114.0 114.0 114.0 116.0 114.0 114.0 114.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 01:29:09 INFO - PID 13974 | Values: 150.0 152.0 151.0 151.0 152.0 151.0 150.0 152.0 151.0 150.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.00 stddev:3.74 (4.0%) stddev-sans-first:3.90 01:29:09 INFO - PID 13974 | Values: 94.0 95.0 104.0 94.0 102.0 94.0 94.0 95.0 94.0 94.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:2.21 (3.9%) stddev-sans-first:2.32 01:29:09 INFO - PID 13974 | Values: 57.0 58.0 57.0 57.0 57.0 57.0 57.0 64.0 57.0 59.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:54.00 stddev:4.36 (8.1%) stddev-sans-first:4.57 01:29:09 INFO - PID 13974 | Values: 54.0 54.0 54.0 55.0 54.0 53.0 54.0 67.0 54.0 60.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.00 stddev:8.13 (10.0%) stddev-sans-first:8.44 01:29:09 INFO - PID 13974 | Values: 80.0 99.0 81.0 90.0 81.0 99.0 80.0 80.0 79.0 79.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:132.00 stddev:13.80 (10.5%) stddev-sans-first:14.64 01:29:09 INFO - PID 13974 | Values: 135.0 132.0 132.0 126.0 130.0 129.0 124.0 139.0 128.0 172.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:179.50 stddev:3.33 (1.9%) stddev-sans-first:3.21 01:29:09 INFO - PID 13974 | Values: 183.0 178.0 179.0 180.0 183.0 180.0 179.0 178.0 179.0 171.0 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:2.33 (3.3%) stddev-sans-first:2.45 01:29:09 INFO - PID 13974 | Values: 69.0 69.0 72.0 70.0 67.0 68.0 75.0 71.0 68.0 70.0 01:29:09 INFO - PID 13974 | -------- Summary: end -------- 01:29:09 INFO - PID 13974 | 01:29:09 INFO - PID 13974 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:29:10 INFO - TEST-INFO | 13974: exit 0 01:29:10 INFO - TEST-OK | kraken | took 61952ms 01:29:10 INFO - SUITE-END | took 1173s 01:29:10 INFO - Completed test suite (00:19:34) 01:29:10 INFO - javascript benchmark 01:29:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8492.671914836379, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.2740569668977, 3172.77790554661, 3191.2341038150844, 3207.7273431758313, 3212.726918211951, 6220.968895155518, 6282.183316168897, 6340.809775706724, 6362.650054247015, 6391.552591318604, 6163.938360616393, 6254.655993920333, 6305.148804911336, 6332.176817013793, 6339.01745229489, 5664.660120392779, 5733.254676891998, 5750.453706897838, 5765.625234359753, 5788.768449262025, 5755.107958266454, 5825.592208545403, 5833.970830145865, 5845.0647896336595, 5849.941500584982, 69.48957860702009, 5694.601377903548, 5742.655440673573, 5761.193432919353, 5821.8835623287505, 5661.547076233891, 5665.915011274793, 5755.30936287644, 5758.971205143947, 5763.567732420085, 5663.1505274208785, 5664.518515926151, 5757.280339957505, 5766.365699773021, 5776.960147173507, 6115.663638499881, 6147.231596050494, 6160.722767475474, 6236.43872051513, 6245.313015568284, 6636.800895973129, 6639.070530125786, 6640.136782218329, 6741.393274605309, 6747.359000894956, 6736.5958042517605, 6760.32396760325, 6831.487638427137, 6834.897476537856, 6846.623435711034, 6223.097650840648, 6254.405831446005, 6310.148130002437, 6325.051242313643, 6342.873142537123, 6937.861242775116, 7015.824604384829, 7027.824304392431, 7036.155661320674, 7050.294970502909, 6649.135612370361, 6690.297518760557, 6710.865782684319, 6725.05849181115, 6734.797956061326, 6733.42765864907, 6749.595024298558, 6757.256701762803, 6835.58986460814, 6846.828829279308, 6598.307177746267, 6667.066610674509, 6671.39957403836, 6694.163229596301, 6827.317268273232, 6670.794922245665, 6747.831304217434, 6768.932310676929, 6772.085768421299, 6774.288699686561, 5428.945710542923, 5429.53848922846, 5430.755615997289, 5431.891362172734, 5437.728113594305, 4622.399088118523, 4684.414448193976, 4701.905961880743, 4713.74074425903, 4727.338172655831, 5763.682997435181, 5768.971155144198, 5853.1220316952795, 5867.0, 5871.970640146772, 6645.269020407752, 6724.226713927863, 6744.966275168593, 6794.150731158606, 6815.420689241371, 5803.216565763652, 5821.621594596338, 5821.650700957956, 5828.154917536934, 5828.388019257917, 5896.233489646319, 5901.40985901415, 5903.852403689856, 5917.31950825652, 5924.644521328734, 6488.026795980546, 6538.0, 6550.443212326911, 6573.441257493071, 6574.3754343337305, 5867.618604790675, 6718.697658605277, 6745.696443659949, 6836.0, 6854.971754236904, 6485.772997945238, 6527.51043671717, 6590.0, 6596.769113081019, 6599.175103112111, 6531.738730450728, 6601.768938087144, 6617.636030018202, 6625.105610742681, 6638.17022872141, 6705.366075939398, 6718.798436046926, 6806.319368063352, 6813.250542440427, 6813.250542440427, 6521.184851893513, 6557.704903279268, 6562.704678289393, 6575.210974683068, 6681.498887583353, 6504.414602685781, 6504.4796416285635, 6578.440832529097, 6603.867922641424, 6633.1045308882685, 6403.231612206565, 6511.544191906711, 6511.576747511396, 6513.348665133638, 6519.967400162969, 6569.967150164219, 6592.80221593353, 6609.3060228675295, 6620.2386725527185, 6685.164354455693, 6257.78097766576, 6367.0, 6384.553081284265, 6393.360663933569, 6481.189851268591], "value": 6103.599210267717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.1394437035816, 829.208106258523, 854.2567965869692, 1174.0666170394536, 1197.4372045138782, 31266.68733312666, 42334.0, 42935.57064429355, 42937.35593966093, 42944.78527607358, 42789.14421711564, 42959.57040429595, 43005.13989720204, 43266.783666081705, 43271.35092973608, 7857.2535609117185, 7928.643211055516, 7942.166072562384, 8011.719589814357, 8014.919850801476, 7786.182450842636, 7931.24653157952, 7932.841343173162, 7933.523988560676, 7933.563653999027, 7358.889616655754, 7918.683252669886, 7967.322777563914, 7988.560629165394, 8005.279524842763, 7874.9212507875045, 7891.723789667334, 7895.131535531087, 7933.880991785128, 7940.841183176333, 7564.546127232384, 7710.884336734954, 7769.145394006655, 7811.882821757678, 7893.447458677895, 39056.414153787715, 39574.60425395738, 39588.80205598982, 39817.60182398197, 39865.40201896974, 3412.4198886189406, 3412.709919656832, 3428.468587368962, 3430.828458577061, 3431.571053618273, 32292.838535807405, 32342.676573234436, 32367.0, 32449.0, 32465.51301730476, 4808.927866082012, 4921.434035085975, 4923.08922849274, 4931.827386041471, 4945.455999840015, 194127.0, 195712.0, 198065.0, 198517.0, 198867.0, 49414.50585494171, 49931.750341248786, 50107.74946125246, 50500.74749626228, 50552.494475055515, 52602.0, 52681.47318526842, 52682.73658631759, 52728.20907686388, 52803.73598131985, 16391.672166556604, 16495.670086598202, 16526.0, 16530.66938661244, 16532.173391330387, 13347.399367028507, 13378.531751388655, 13392.330383480787, 13394.464221431228, 13475.865241347658, 12656.746865062647, 13902.0, 14003.159810411407, 14123.0, 14173.78739318911, 5024.196128619404, 6017.578769486094, 6038.154658347835, 6202.596831205957, 6305.936940630627, 975.4001289207087, 987.5111819649176, 996.3374356053289, 1023.7082431506984, 1024.3546565663585, 23087.19194828173, 23263.0, 23427.765722342898, 23559.293221203392, 23669.053237870638, 1048.2190767877828, 1102.0302134122082, 1105.2429086076063, 1113.1595645287755, 1120.4117838135044, 11794.846577498, 12261.448234829453, 15447.613809654624, 15658.843411565738, 16230.675386492205, 215447.0, 219981.0, 232611.0, 233411.0, 236541.0, 58169.709151454816, 58419.0, 58516.70741646265, 58832.41167588355, 58865.41134588685, 1471.3452513631332, 1475.3213521779887, 1486.9405223791143, 1490.135721281654, 1502.609321576398, 26113.73886261113, 27009.86495067512, 27116.1865144046, 27135.45729085368, 27298.727012729618, 37474.8126259367, 38026.61973380342, 38027.2394552113, 38345.80827095846, 38371.23257534778, 203357.0, 203757.0, 205272.0, 205453.0, 205730.0, 32668.83665581657, 32731.836340818143, 33259.16852078717, 37047.444288336235, 38164.0, 41581.0, 42499.0, 48173.75913120412, 48338.75830620824, 49323.0, 31631.683683163796, 33329.66703329648, 33909.152271193416, 34559.13602159966, 35026.64973350336, 32804.507932380555, 33583.66416335805, 33871.66128338784, 33918.83040584781, 34147.4877876837, 36499.1795256343, 37528.2494350106, 38348.424773628976, 38780.61219387883, 38799.0, 31311.37377252488, 32923.17692057718, 33908.321833563685, 34148.82925585456, 34318.828405857814, 23842.88078559596, 25033.12384066549, 25465.363365916, 25632.87183564145, 25719.0], "value": 17736.65361935866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6523353371213, 580.747374891922, 582.947534721875, 583.646893629354, 603.5232166588395, 22029.889850550746, 22518.43703907403, 23085.538289234228, 23197.18809841656, 23209.535809283825, 24397.75602243977, 25127.0, 25168.0, 25313.493730125385, 25351.492970140585, 6527.0, 6639.900401493981, 6697.564658297195, 6702.597844129368, 6703.128593282866, 6007.4593286604195, 6555.508336874754, 6574.211094668646, 6577.276499585066, 6590.275069742324, 6555.737770489175, 6559.245686746038, 6560.081588577603, 6564.967175164117, 6568.671566421684, 6488.740450381979, 6541.836454088662, 6556.082148499214, 6579.210494740638, 6582.17722784652, 6060.666663333515, 6096.664683442409, 6098.756049758004, 6100.359462256443, 6101.633901965896, 28373.14880553566, 28604.856975715196, 28908.132756017352, 30114.84942575295, 30148.0, 1850.2044121027952, 1886.6509695706338, 1901.7432646592672, 1901.9809801902081, 1902.7526421565108, 18718.0, 18779.0, 19300.1314940828, 19352.70970935437, 19950.201991920305, 2265.184533567914, 2304.320225533472, 2328.7671232876746, 2337.2988103569032, 2344.15610380263, 129875.0, 131980.0, 132040.33979830134, 132198.3390083053, 132426.0, 14011.229382383863, 14881.627959300888, 15006.099634021994, 15153.242337883063, 15235.0, 23389.064437422312, 23451.296461106194, 23490.64764028541, 23574.646380304308, 23590.17434389788, 10039.548220330104, 10079.193664506822, 10361.689149325532, 10371.066604005675, 10410.271281010257, 7561.508501947355, 7977.162397948248, 9341.532923353805, 9455.952720236355, 9483.33616646842, 10830.783384332426, 11272.323660580392, 11302.265352752209, 11338.206325557298, 11780.587679431179, 3902.31709450845, 4201.894952626148, 4224.831006759695, 4273.337632666941, 4398.164348773723, 903.0, 943.8725772020827, 949.2548349545712, 973.3089506450499, 986.4328011393477, 18825.30572248504, 19505.707414388795, 19696.40910772679, 19811.405657830288, 19981.400557983285, 1010.8736407949007, 1013.9340942838692, 1019.4291196929743, 1043.4313299251926, 1049.6693541534546, 10776.353418794897, 13137.934310328386, 13236.867631323756, 14052.36764345607, 14235.43058277678, 447620.0, 465285.0, 471895.0, 476919.0, 488881.0, 113603.0, 116468.0, 116763.0, 117950.0, 118430.40784796193, 1239.5599562155485, 1271.771081205392, 1296.0538806671184, 1298.2016060123144, 1307.9542216022394, 19801.900990494956, 20761.89619051895, 21296.680549792076, 21337.0, 21352.252671156435, 53094.0, 53197.4680253208, 53848.73075634597, 54476.455235448724, 55649.165262520284, 66412.0, 66739.66630166819, 67287.66356168188, 67463.32536674767, 67972.0, 14332.641683957985, 14387.92806036005, 15111.168885710951, 15245.542633721006, 15300.923495382453, 24552.140675076287, 24610.384740381633, 24752.25743227706, 24860.0, 25011.624825627267, 18868.811311886704, 19062.618747624692, 19394.224231031167, 19405.4178374649, 19444.319448819224, 16956.15219239058, 17285.567860803076, 17425.73861392055, 17736.911315443856, 17770.378036768652, 20038.098285576893, 20278.188872444938, 20436.69344959797, 20511.0, 20518.794812052285, 14384.352704128549, 14403.495877644233, 14804.0, 14860.925695371454, 14917.104973701613, 19564.510887227934, 19597.31409400664, 19652.0, 19753.0, 19787.50531236673], "value": 12308.761507238703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.5950834995326, 1365.6790654196266, 1379.5309594737794, 1390.9582712518622, 1396.7555677756402, 13749.65625859354, 14292.142471451694, 14305.141691498491, 14309.713805723879, 14310.21293828839, 13444.865551344483, 13942.302884855742, 14425.278736063206, 14426.927865360658, 14447.927760361183, 2592.64999225105, 2633.4074833162576, 2635.0, 2636.393629465224, 2638.986805065972, 2541.682289713786, 2593.5201987632254, 2645.986770066147, 2650.615660729193, 2651.138380026499, 2659.321872922412, 2666.8666566671686, 2680.6917204521437, 2681.5977603359556, 2689.2066840282064, 2578.2136448383235, 2588.3270349709023, 2604.3619313268277, 2606.3744701271557, 2607.778338841201, 2554.3741783263035, 2563.6026415905562, 2571.434284457416, 2573.1765834932644, 2573.318070711263, 13710.314484275847, 13820.723585528334, 13834.031617786759, 13840.169589824542, 13846.446142154302, 7522.473426860067, 7773.183815699326, 7801.375889928849, 7809.140994490602, 7817.570033648147, 4758.119747846659, 4962.702237865739, 5037.29477873098, 5057.9494205057845, 5067.442581316052, 1793.7937137229126, 1830.670479313723, 1841.539615096226, 1857.2849452960572, 1887.867849250553, 22859.885700571558, 22972.310830675106, 22988.310350689506, 22989.54020919589, 23067.423314417105, 6418.101465794793, 6486.124373209556, 6496.675166241669, 6594.241662208811, 6667.966660166765, 15710.135942523042, 15772.211389430482, 15814.130222837624, 15834.683306333809, 15899.364025438854, 7463.8507229855095, 7602.42981776369, 7651.846963060819, 7658.042744656918, 7669.5398276103615, 6892.276310987374, 6896.620685862225, 7026.0, 7046.92953070473, 7105.644717764091, 4530.796114174804, 4767.141914455362, 4926.0, 4954.133026720309, 4982.800687972513, 1344.2270694350786, 1482.2588705647177, 1496.6707324388617, 1508.0725353907487, 1518.468536012409, 842.4103127810557, 847.6694089305176, 852.2329903087272, 854.4189950833493, 883.8055627761883, 7325.2674732527385, 7469.85060298791, 7591.202923693043, 7734.458587898793, 7790.415718821111, 918.8943271523726, 922.8707980882682, 947.393668052447, 959.6641175588628, 990.3067852503276, 3959.604039596017, 4443.4445694288215, 4791.664583479123, 4823.879403014953, 4843.75781210938, 18073.367432140076, 18643.720344194848, 18762.155702993397, 18775.718364224547, 18776.0, 18148.546286342684, 18596.907015464836, 19610.313639022566, 19642.214311427382, 19730.70403943942, 10762.784744305227, 11006.889931100906, 11031.172662050218, 11065.557377704963, 11099.223054386115, 6980.860382792214, 7335.523190992569, 7390.150132734804, 7484.101907771103, 7549.622518874145, 16492.42276520316, 16688.415905443253, 16775.412860549823, 16825.495235142964, 17580.120993950506, 16543.503694889172, 17250.65498690044, 17344.132793360535, 17463.82536174622, 17600.823991759917, 11058.502367393326, 11350.375729334966, 11351.659450216506, 11351.716207094889, 11356.943215284202, 12635.747285054063, 12887.09790314669, 12927.353632318158, 12983.221006739626, 13019.869801302244, 10032.147267482345, 10583.94708026455, 10619.840702389316, 10731.839022414513, 10909.727256818325, 10325.535350909076, 10444.112250458797, 10463.895361046292, 10991.890081099087, 11002.449877506253, 8819.867701984604, 8832.425892316978, 8923.955380223057, 8924.86612700823, 8938.910610894069, 6483.351664833479, 6797.626130562867, 6872.072270243653, 6886.10480637514, 6951.965240173767, 6679.398854103154, 6715.227748808949, 6774.458043356618, 6883.552569082994, 6946.687399067156], "value": 6259.008359178339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.0617589544295, 507.55588859747724, 522.1306524636481, 529.7271904968942, 531.3199105145416, 6253.843653908654, 6286.528510361724, 6293.0737207198645, 6304.558680892339, 6315.968420157898, 5938.228030356058, 6010.6093103948215, 6055.545834062441, 6060.636361818294, 6118.632882027082, 4882.048000639877, 4883.706977581339, 4896.755162241891, 4924.655274130812, 4927.975360123212, 4770.713757174563, 4874.488178741234, 4887.462379138292, 4892.535209155125, 4928.137575924216, 4943.406791185045, 5011.699298042111, 5039.3196918415915, 5044.0, 5079.4412614612365, 5005.599552035828, 5063.569596584295, 5088.974555127201, 5096.592272618182, 5130.179171332569, 4713.976430117862, 4729.574338309534, 4731.1720448921305, 4785.396892041171, 4788.162071637485, 5925.31858836235, 5998.490128339096, 6041.5468839837185, 6052.182955301022, 6077.726502307407, 5783.21926539916, 5791.305043394819, 5835.562332825055, 5891.3814049525035, 5906.704664766788, 6410.358964103552, 6473.676316184172, 6480.222373315232, 6510.772122975721, 6550.886349320579, 5131.820386286462, 5139.820106296262, 5214.608904332153, 5222.712750798704, 5227.947720522822, 6889.276625954253, 6897.48268879841, 6899.275576064491, 6940.41006514452, 6941.5140940134215, 5272.367315922113, 5294.57643388528, 5329.920051199235, 5380.677159370451, 5387.9461205388225, 5376.0, 5425.348958125051, 5448.645838020516, 5471.753771080232, 5472.370677372073, 5839.773647533981, 5866.882662346729, 5875.206847075676, 5887.646741195542, 5931.73307201177, 6443.7744678936015, 6490.2536208335705, 6537.836554086186, 6567.868642627121, 6644.468442524587, 1822.963540729178, 1865.9008615307778, 1874.4845167578753, 1894.8768330058501, 1931.5460866696314, 1359.8776110150134, 1395.4976208564908, 1449.6375906023495, 1455.2432734977751, 1460.072853737863, 5581.0, 5700.37295897451, 5748.166515855178, 5750.741216645261, 5763.106718458645, 6488.675566221765, 6514.850099467165, 6588.604683718896, 6596.340365963365, 6600.570962887493, 5722.227499287626, 5726.9713651431475, 5730.36965933747, 5746.0, 5766.481016708516, 3511.8595256189465, 3518.5222206673257, 3549.254656522159, 3550.396432606463, 3551.183227857607, 6385.233771947396, 6424.196975378078, 6450.354964503512, 6517.3808488193545, 6566.8358291043105, 6862.622555759481, 6873.4157596603845, 6918.688659010357, 6925.757598484029, 6971.163460384685, 6534.444572211415, 6551.6069035858, 6563.540552161398, 6574.192097173315, 6580.901286480611, 6750.831229219112, 6755.3582409671, 6759.5606285591275, 6760.425363844129, 6772.762953296611, 6616.470682345497, 6627.635480048643, 6638.468922486286, 6679.76620818269, 6726.495512836655, 6344.841378965562, 6378.617282963037, 6493.2857385688485, 6505.804825855232, 6534.673266336759, 4823.782929768239, 4905.9018819624125, 4915.164422048332, 4919.581835544019, 4926.211806111005, 6733.478547590928, 6764.763233287008, 6784.932150678627, 6837.829054273484, 6838.14523184602, 6377.904331434939, 6414.294427613052, 6468.450181734605, 6477.546571739933, 6547.181602299713, 6386.840328991812, 6416.711247993758, 6470.7088181032905, 6521.739130434729, 6530.771423000172, 6117.357677443804, 6387.233531976192, 6410.679466026773, 6460.515461340325, 6493.116996071087, 6379.553431259767, 6520.836979075561, 6524.217093948567, 6547.214334279726, 6552.803415897531, 6295.905561416491, 6296.433321000949, 6321.96839015802, 6323.588966717149, 6334.6832658365975], "value": 5113.484590473455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.1265528764741, 916.1891725822647, 923.4044041593172, 926.305271046715, 926.3654396738231, 17879.19543620537, 18851.340203092877, 18887.15007824648, 18909.338173163942, 20239.59520809583, 19915.004249787526, 21018.894905525452, 21184.57630847382, 21274.680879786778, 21289.0, 1051.4690081508847, 1070.288258308228, 1076.4994277660885, 1077.5905156040694, 1078.2937176149635, 1059.8781140168903, 1063.4363787192801, 1064.2603390643505, 1064.7551063255455, 1065.4619417194306, 1073.425717241276, 1119.0655802405001, 1125.6397952655154, 1128.401946968104, 1129.3619105205573, 1110.3393480878945, 1114.7380365614074, 1118.2675347647305, 1118.35694475676, 1120.8710998235185, 798.0104670208957, 798.8522123407188, 799.2167675677811, 802.7952872017656, 803.8553060449117, 18485.0, 19121.23515059396, 19301.61396772057, 19373.61252774951, 19448.4165475036, 19814.80185198144, 20137.597248055103, 20164.19343226269, 20302.492437689176, 20313.0, 15351.309191086428, 15353.15557644329, 15605.765913511306, 15620.297086631128, 15673.843261567352, 3443.3974054540604, 3482.0424383294544, 3482.860685572574, 3494.5631796025496, 3499.6500349965054, 118223.0, 118391.0, 121476.39261803722, 123830.0, 123922.38038809749, 15641.217939102999, 15824.129672867872, 15993.28030238642, 16004.03975761458, 16034.278457469441, 29644.407111857643, 29731.0, 29754.553681694793, 29790.0, 29868.40263194724, 7611.771646850603, 8187.549684767276, 8281.089080201173, 8645.654173833102, 8702.260307873776, 3984.3425834737523, 4248.129133527619, 4259.7231179973205, 4267.594578515036, 4271.060366719316, 4899.020195960751, 4957.206846904478, 5021.447640759514, 5026.220935754964, 5101.795928162832, 1025.8409946458312, 1049.7742985258205, 1069.0645685025602, 1070.1171533484905, 1073.7906108308962, 660.3825423229296, 668.2815972829228, 675.5074847595987, 703.9859202815915, 707.7912015955305, 10761.569537218424, 11218.214724969173, 11416.42917854104, 11497.310161390344, 11971.74296698834, 633.8383712153371, 636.1888592045087, 645.2257291250518, 649.8797722421367, 650.6844180572418, 5129.615278854101, 5142.305788718475, 5199.688018718889, 5338.119210330252, 5370.301860758076, 97884.0, 101663.49168254112, 104872.47563762132, 106046.0, 108284.45857770661, 87898.0, 91061.0, 91394.54302728444, 92659.0, 95258.0, 79779.0, 80172.0, 80936.59531702304, 83050.16949830545, 83345.58327208325, 11076.0, 11160.162987775788, 11361.659150225507, 11594.5362185515, 12106.939465302617, 32603.34793304168, 33877.0, 34017.14957126092, 35383.0, 35712.28575428425, 42374.788126059175, 61841.69079154755, 62203.377966219756, 62822.0, 66191.00713489205, 15490.9225453872, 15562.922185389001, 15629.609259768142, 15688.529344119695, 16911.238994245534, 15963.042217466525, 16712.582185444975, 17000.829991699924, 17077.573060673087, 18640.627187456445, 16635.0, 16766.66466670684, 17383.47849564515, 17623.735643965607, 17833.554161146076, 16334.346626134822, 16500.17499125063, 16582.917085414494, 16643.251053702854, 16709.415170469463, 17338.393156239974, 17688.027158506407, 17918.820811791717, 17943.282268709107, 17966.371177009263, 12519.54168563149, 12880.806787898002, 12991.090623656253, 13201.60395188146, 13813.240271784747, 12133.514659413524, 12397.512298524234, 12751.553695620609, 12960.805587916377, 13454.663633409244], "value": 8797.185948880277, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 104.0, 109.0, 110.0, 111.0, 110.0, 102.0, 111.0, 112.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 147.0, 173.0, 119.0, 143.0, 151.0, 121.0, 172.0, 119.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 165.0, 161.0, 163.0, 166.0, 170.0, 162.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 165.0, 77.0, 76.0, 77.0, 76.0, 148.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 132.0, 79.0, 79.0, 79.0, 137.0, 79.0, 79.0, 131.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 151.0, 152.0, 151.0, 150.0, 152.0, 151.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 104.0, 94.0, 102.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 64.0, 57.0, 59.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 53.0, 54.0, 67.0, 54.0, 60.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 99.0, 81.0, 90.0, 81.0, 99.0, 80.0, 80.0, 79.0, 79.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 132.0, 126.0, 130.0, 129.0, 124.0, 139.0, 128.0, 172.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 178.0, 179.0, 180.0, 183.0, 180.0, 179.0, 178.0, 179.0, 171.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 72.0, 70.0, 67.0, 68.0, 75.0, 71.0, 68.0, 70.0], "value": 69.9, "unit": "score"}]}]} 01:29:10 INFO - Return code: 0 01:29:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:29:10 INFO - # TBPL SUCCESS # 01:29:10 INFO - Running post-action listener: _package_coverage_data 01:29:10 INFO - Running post-action listener: _resource_record_post_action 01:29:10 INFO - [mozharness: 2017-07-28 08:29:10.716516Z] Finished run-tests step (success) 01:29:10 INFO - Running post-run listener: _resource_record_post_run 01:29:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 16384; Write bytes: 430166016; Read time: 220; Write time: 256584 01:29:10 INFO - TinderboxPrint: CPU usage
13.1% 01:29:10 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 220 01:29:10 INFO - TinderboxPrint: I/O write bytes / time
430,166,016 / 256,584 01:29:10 INFO - TinderboxPrint: CPU idle
8,263.2 (86.9%) 01:29:10 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 01:29:10 INFO - TinderboxPrint: Swap in / out
0 / 0 01:29:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107548672; Read time: 0; Write time: 80216 01:29:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:29:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 322617344; Read time: 212; Write time: 176368 01:29:11 INFO - Running post-run listener: _upload_blobber_files 01:29:11 INFO - Blob upload gear active. 01:29:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:29:11 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'] 01:29:11 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 01:29:11 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:12 INFO - (blobuploader) - INFO - Done attempting. 01:29:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:29:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:29:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:13 INFO - (blobuploader) - INFO - Done attempting. 01:29:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:29:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:29:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:14 INFO - (blobuploader) - INFO - Done attempting. 01:29:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:29:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:29:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:21 INFO - (blobuploader) - INFO - Done attempting. 01:29:21 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:21 INFO - Return code: 0 01:29:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83e37ea58ace174b55f88d00b8feec19805f493c5f72b62e33be273354d612d502096f9396492680a336739fe78cf7772221805d9f4b9cd3e8f75fa927f51eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eaf6daccef206c49a8e9e9ef6eccb51c030472416d66da9cf4f7f164cedabdfaf84c2c6b0911e23960f8b7780837c251d257318e1b70b7002b7b15e44511623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61c8f997b5e6d54fe82c2188e7998a9f11ea79cbe0d08b7dc028961f4704368d08bf991c7a91bf56064d35fa09f57eb0da8f9a5f03392756bc7387803f8a3939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f9b21f4b98213dc46532b0f6d9ba29c9d7754e4c4b4dde569cd537c7d270e2b6b132d42eddcc2628ce005ce80828c035f6649cb13c343ce4f09316eec970fe6"} 01:29:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:21 INFO - Contents: 01:29:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83e37ea58ace174b55f88d00b8feec19805f493c5f72b62e33be273354d612d502096f9396492680a336739fe78cf7772221805d9f4b9cd3e8f75fa927f51eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eaf6daccef206c49a8e9e9ef6eccb51c030472416d66da9cf4f7f164cedabdfaf84c2c6b0911e23960f8b7780837c251d257318e1b70b7002b7b15e44511623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61c8f997b5e6d54fe82c2188e7998a9f11ea79cbe0d08b7dc028961f4704368d08bf991c7a91bf56064d35fa09f57eb0da8f9a5f03392756bc7387803f8a3939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f9b21f4b98213dc46532b0f6d9ba29c9d7754e4c4b4dde569cd537c7d270e2b6b132d42eddcc2628ce005ce80828c035f6649cb13c343ce4f09316eec970fe6"} 01:29:21 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:21 INFO - Copying logs to upload dir... 01:29:21 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.316124 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-28 01:29:21.321018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:21.324409) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83e37ea58ace174b55f88d00b8feec19805f493c5f72b62e33be273354d612d502096f9396492680a336739fe78cf7772221805d9f4b9cd3e8f75fa927f51eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eaf6daccef206c49a8e9e9ef6eccb51c030472416d66da9cf4f7f164cedabdfaf84c2c6b0911e23960f8b7780837c251d257318e1b70b7002b7b15e44511623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61c8f997b5e6d54fe82c2188e7998a9f11ea79cbe0d08b7dc028961f4704368d08bf991c7a91bf56064d35fa09f57eb0da8f9a5f03392756bc7387803f8a3939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f9b21f4b98213dc46532b0f6d9ba29c9d7754e4c4b4dde569cd537c7d270e2b6b132d42eddcc2628ce005ce80828c035f6649cb13c343ce4f09316eec970fe6"} build_url:https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/Q_0oAkbmSxa4brTQ_KIZPg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a83e37ea58ace174b55f88d00b8feec19805f493c5f72b62e33be273354d612d502096f9396492680a336739fe78cf7772221805d9f4b9cd3e8f75fa927f51eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0eaf6daccef206c49a8e9e9ef6eccb51c030472416d66da9cf4f7f164cedabdfaf84c2c6b0911e23960f8b7780837c251d257318e1b70b7002b7b15e44511623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/61c8f997b5e6d54fe82c2188e7998a9f11ea79cbe0d08b7dc028961f4704368d08bf991c7a91bf56064d35fa09f57eb0da8f9a5f03392756bc7387803f8a3939", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f9b21f4b98213dc46532b0f6d9ba29c9d7754e4c4b4dde569cd537c7d270e2b6b132d42eddcc2628ce005ce80828c035f6649cb13c343ce4f09316eec970fe6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:21.351067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:21.351476) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501228543.79861-1794868837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 01:29:21.432188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 01:29:21.432508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 01:29:21.433055) ========= ========= Total master_lag: 0.19 =========