builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1502105724.78 results: success (0) revision: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:24.782699) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:24.783166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:24.783453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:24.836939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-07 04:35:24.837556) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 04:35:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-08-07 04:35:26 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.149524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-07 04:35:26.008841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:26.009217) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:26.065346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-08-07 04:35:26.068716) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 --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 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 --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=9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 04:35:26,196 truncating revision to first 12 chars 2017-08-07 04:35:26,196 Setting DEBUG logging. 2017-08-07 04:35:26,196 attempt 1/10 2017-08-07 04:35:26,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/347ea0d06092?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-07 04:35:28,868 unpacking tar archive at: mozilla-central-347ea0d06092/testing/mozharness/ program finished with exit code 0 elapsedTime=3.016464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-08-07 04:35:29.100023) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:29.100359) ========= script_repo_revision: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:29.100799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:29.101091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 04:35:29.115615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-08-07 04:35:29.115966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:35:29 INFO - MultiFileLogger online at 20170807 04:35:29 in /builds/slave/test 04:35:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:35:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:29 INFO - {'append_to_log': False, 04:35:29 INFO - 'base_work_dir': '/builds/slave/test', 04:35:29 INFO - 'blob_upload_branch': 'Firefox', 04:35:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:29 INFO - 'branch': 'Firefox', 04:35:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:29 INFO - 'code_coverage': False, 04:35:29 INFO - 'config_files': ('talos/linux_config.py',), 04:35:29 INFO - 'default_actions': ('clobber', 04:35:29 INFO - 'read-buildbot-config', 04:35:29 INFO - 'download-and-extract', 04:35:29 INFO - 'populate-webroot', 04:35:29 INFO - 'create-virtualenv', 04:35:29 INFO - 'install', 04:35:29 INFO - 'setup-mitmproxy', 04:35:29 INFO - 'run-tests'), 04:35:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:29 INFO - 'disable_ccov_upload': False, 04:35:29 INFO - 'download_minidump_stackwalk': True, 04:35:29 INFO - 'download_symbols': 'ondemand', 04:35:29 INFO - 'enable_stylo': False, 04:35:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:29 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:29 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:29 INFO - 'gecko_profile': False, 04:35:29 INFO - 'gecko_profile_interval': 0, 04:35:29 INFO - 'installer_path': 'installer.exe', 04:35:29 INFO - 'log_level': 'info', 04:35:29 INFO - 'log_name': 'talos', 04:35:29 INFO - 'log_to_console': True, 04:35:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:35:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:35:29 INFO - 'opt_config_files': (), 04:35:29 INFO - 'pip_index': False, 04:35:29 INFO - 'suite': 'dromaeojs-e10s', 04:35:29 INFO - 'system_bits': '32', 04:35:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:29 INFO - 'title': 'talos-linux64-ix-088', 04:35:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:29 INFO - 'use_talos_json': True, 04:35:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:29 INFO - 'work_dir': 'build'} 04:35:29 INFO - [mozharness: 2017-08-07 11:35:29.346400Z] Running clobber step. 04:35:29 INFO - Running pre-action listener: _resource_record_pre_action 04:35:29 INFO - Running main action method: clobber 04:35:29 INFO - rmtree: /builds/slave/test/build 04:35:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:30 INFO - Running post-action listener: _resource_record_post_action 04:35:30 INFO - [mozharness: 2017-08-07 11:35:30.365632Z] Finished clobber step (success) 04:35:30 INFO - [mozharness: 2017-08-07 11:35:30.365736Z] Running read-buildbot-config step. 04:35:30 INFO - Running pre-action listener: _resource_record_pre_action 04:35:30 INFO - Running main action method: read_buildbot_config 04:35:30 INFO - Using buildbot properties: 04:35:30 INFO - { 04:35:30 INFO - "project": "", 04:35:30 INFO - "product": "firefox", 04:35:30 INFO - "who": "cbook@mozilla.com", 04:35:30 INFO - "installer_path": "public/build/target.tar.bz2", 04:35:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:35:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:35:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:35:30 INFO - "stage_platform": "linux64-stylosequential", 04:35:30 INFO - "basedir": "/builds/slave/test", 04:35:30 INFO - "buildnumber": 138, 04:35:30 INFO - "platform": "ubuntu64_hw_styloseq", 04:35:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:35:30 INFO - "slavebuilddir": "test", 04:35:30 INFO - "taskId": "GW0eHKVkRZqX1Jb7fCjbaQ", 04:35:30 INFO - "branch": "mozilla-central", 04:35:30 INFO - "script_repo_revision": "production", 04:35:30 INFO - "revision": "347ea0d06092d7fcd6c34e2c7ade389b0b71ae31", 04:35:30 INFO - "slavename": "talos-linux64-ix-088", 04:35:30 INFO - "repo_path": "mozilla-central" 04:35:30 INFO - } 04:35:30 INFO - Finding installer, test and symbols from parent task. 04:35:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GW0eHKVkRZqX1Jb7fCjbaQ'}, attempt #1 04:35:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GW0eHKVkRZqX1Jb7fCjbaQ'}, attempt #1 04:35:34 INFO - Task dependencies: S8ufqNiHTaGHbnSuZ_Q5fA 04:35:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA'}, attempt #1 04:35:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:35:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.test_packages.json 04:35:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.crashreporter-symbols.zip 04:35:35 INFO - Running post-action listener: _resource_record_post_action 04:35:35 INFO - [mozharness: 2017-08-07 11:35:35.936955Z] Finished read-buildbot-config step (success) 04:35:35 INFO - [mozharness: 2017-08-07 11:35:35.937179Z] Running download-and-extract step. 04:35:35 INFO - Running pre-action listener: _resource_record_pre_action 04:35:35 INFO - Running main action method: download_and_extract 04:35:35 INFO - mkdir: /builds/slave/test/build/tests 04:35: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')]} 04:35:35 INFO - trying https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.test_packages.json 04:35:35 INFO - Downloading https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:35:37 INFO - Downloaded 989 bytes. 04:35:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:35:37 INFO - Using the following test package requirements: 04:35:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:35:37 INFO - u'common': [u'target.common.tests.zip'], 04:35:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:35:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:35:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:35:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:35:37 INFO - u'mozbase': [u'target.common.tests.zip'], 04:35:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:35:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:35:37 INFO - u'web-platform': [u'target.common.tests.zip', 04:35:37 INFO - u'target.web-platform.tests.tar.gz'], 04:35:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:35:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:35:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip 04:35:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:35:37 INFO - Fetch https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip into memory 04:35:39 INFO - Content-Length response header: 54284817 04:35:39 INFO - Bytes received: 54284817 04:35:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:35:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip 04:35:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:35:50 INFO - Fetch https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip into memory 04:35:52 INFO - Content-Length response header: 54284817 04:35:52 INFO - Bytes received: 54284817 04:36:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.talos.tests.zip 04:36:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:36:05 INFO - Fetch https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.talos.tests.zip into memory 04:36:08 INFO - Content-Length response header: 14496008 04:36:08 INFO - Bytes received: 14496008 04:36: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')]} 04:36:08 INFO - trying https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:08 INFO - Downloading https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:36:10 INFO - Downloaded 61730205 bytes. 04:36:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:10 INFO - mkdir: /builds/slave/test/properties 04:36:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:10 INFO - Contents: 04:36:10 INFO - build_url:https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:10 INFO - Running post-action listener: _resource_record_post_action 04:36:10 INFO - Running post-action listener: set_extra_try_arguments 04:36:10 INFO - [mozharness: 2017-08-07 11:36:10.371215Z] Finished download-and-extract step (success) 04:36:10 INFO - [mozharness: 2017-08-07 11:36:10.371313Z] Running populate-webroot step. 04:36:10 INFO - Running pre-action listener: _resource_record_pre_action 04:36:10 INFO - Running main action method: populate_webroot 04:36:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:10 INFO - 'tests': ['damp', 'tps']}, 04:36:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:36:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:36:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:36:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:10 INFO - 'ts_paint', 04:36:10 INFO - 'tpaint', 04:36:10 INFO - 'sessionrestore', 04:36:10 INFO - 'sessionrestore_many_windows', 04:36:10 INFO - 'sessionrestore_no_auto_restore', 04:36:10 INFO - 'tabpaint']}, 04:36:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:36:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:36:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:10 INFO - 'tsvgr_opacity', 04:36:10 INFO - 'tart', 04:36:10 INFO - 'tscrollx', 04:36:10 INFO - 'tsvg_static']}, 04:36:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:10 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:36:10 INFO - 'talos_options': ['--mitmproxy', 04:36:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:36:10 INFO - '--firstNonBlankPaint'], 04:36:10 INFO - 'tests': ['tp6_google', 04:36:10 INFO - 'tp6_youtube', 04:36:10 INFO - 'tp6_amazon', 04:36:10 INFO - 'tp6_facebook']}, 04:36:10 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:36:10 INFO - 'talos_options': ['--stylo', 04:36:10 INFO - '--mitmproxy', 04:36:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:36:10 INFO - '--firstNonBlankPaint'], 04:36:10 INFO - 'tests': ['tp6_google', 04:36:10 INFO - 'tp6_youtube', 04:36:10 INFO - 'tp6_amazon', 04:36:10 INFO - 'tp6_facebook']}, 04:36:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:36:10 INFO - 'talos_options': ['--stylo', 04:36:10 INFO - '--stylo-threads=1', 04:36:10 INFO - '--mitmproxy', 04:36:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:36:10 INFO - '--firstNonBlankPaint'], 04:36:10 INFO - 'tests': ['tp6_google', 04:36:10 INFO - 'tp6_youtube', 04:36:10 INFO - 'tp6_amazon', 04:36:10 INFO - 'tp6_facebook']}, 04:36:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:10 INFO - 'talos_options': ['--xperf_path', 04:36:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:10 INFO - 'tests': ['tp5n']}}} 04:36:10 INFO - Running post-action listener: _resource_record_post_action 04:36:10 INFO - [mozharness: 2017-08-07 11:36:10.379714Z] Finished populate-webroot step (success) 04:36:10 INFO - [mozharness: 2017-08-07 11:36:10.379804Z] Running create-virtualenv step. 04:36:10 INFO - Running pre-action listener: _resource_record_pre_action 04:36:10 INFO - Running main action method: create_virtualenv 04:36:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:36:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:36:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:10 INFO - Using real prefix '/usr' 04:36:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:12 INFO - Installing pip.................done. 04:36:12 INFO - Return code: 0 04:36:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:13 INFO - Reading from file tmpfile_stdout 04:36:13 INFO - Output received: 04:36:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:36:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:36:13 INFO - Using env: {'DISPLAY': ':0', 04:36:13 INFO - 'HOME': '/home/cltbld', 04:36:13 INFO - 'LANG': 'en_US.UTF-8', 04:36:13 INFO - 'LANGUAGE': 'en_US:en', 04:36:13 INFO - 'LOGNAME': 'cltbld', 04:36:13 INFO - 'MAIL': '/var/mail/cltbld', 04:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:13 INFO - 'MOZ_NO_REMOTE': '1', 04:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:13 INFO - 'NO_EM_RESTART': '1', 04:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:13 INFO - 'PWD': '/builds/slave/test', 04:36:13 INFO - 'SHELL': '/bin/bash', 04:36:13 INFO - 'SHLVL': '1', 04:36:13 INFO - 'TERM': 'linux', 04:36:13 INFO - 'TMOUT': '86400', 04:36:13 INFO - 'USER': 'cltbld', 04:36:13 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:13 INFO - '_': '/tools/buildbot/bin/python'} 04:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:36:13 INFO - Cleaning up... 04:36:13 INFO - Return code: 0 04:36:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:36:14 INFO - Using env: {'DISPLAY': ':0', 04:36:14 INFO - 'HOME': '/home/cltbld', 04:36:14 INFO - 'LANG': 'en_US.UTF-8', 04:36:14 INFO - 'LANGUAGE': 'en_US:en', 04:36:14 INFO - 'LOGNAME': 'cltbld', 04:36:14 INFO - 'MAIL': '/var/mail/cltbld', 04:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:14 INFO - 'MOZ_NO_REMOTE': '1', 04:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:14 INFO - 'NO_EM_RESTART': '1', 04:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:14 INFO - 'PWD': '/builds/slave/test', 04:36:14 INFO - 'SHELL': '/bin/bash', 04:36:14 INFO - 'SHLVL': '1', 04:36:14 INFO - 'TERM': 'linux', 04:36:14 INFO - 'TMOUT': '86400', 04:36:14 INFO - 'USER': 'cltbld', 04:36:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:14 INFO - '_': '/tools/buildbot/bin/python'} 04:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:14 INFO - Downloading/unpacking psutil>=3.1.1 04:36: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 04:36: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 04:36: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 04:36: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 04:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:15 INFO - Installing collected packages: psutil 04:36:15 INFO - Running setup.py install for psutil 04:36:16 INFO - building 'psutil._psutil_linux' extension 04:36:16 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 04:36:16 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 04:36:16 INFO - building 'psutil._psutil_posix' extension 04:36:16 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 04:36:16 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 04:36:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:16 INFO - Successfully installed psutil 04:36:16 INFO - Cleaning up... 04:36:16 INFO - Return code: 0 04:36:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:36:16 INFO - Using env: {'DISPLAY': ':0', 04:36:16 INFO - 'HOME': '/home/cltbld', 04:36:16 INFO - 'LANG': 'en_US.UTF-8', 04:36:16 INFO - 'LANGUAGE': 'en_US:en', 04:36:16 INFO - 'LOGNAME': 'cltbld', 04:36:16 INFO - 'MAIL': '/var/mail/cltbld', 04:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:16 INFO - 'MOZ_NO_REMOTE': '1', 04:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:16 INFO - 'NO_EM_RESTART': '1', 04:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:16 INFO - 'PWD': '/builds/slave/test', 04:36:16 INFO - 'SHELL': '/bin/bash', 04:36:16 INFO - 'SHLVL': '1', 04:36:16 INFO - 'TERM': 'linux', 04:36:16 INFO - 'TMOUT': '86400', 04:36:16 INFO - 'USER': 'cltbld', 04:36:16 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:16 INFO - '_': '/tools/buildbot/bin/python'} 04:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:19 INFO - Installing collected packages: mozsystemmonitor 04:36:19 INFO - Running setup.py install for mozsystemmonitor 04:36:19 INFO - Successfully installed mozsystemmonitor 04:36:19 INFO - Cleaning up... 04:36:19 INFO - Return code: 0 04:36:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:36:19 INFO - Using env: {'DISPLAY': ':0', 04:36:19 INFO - 'HOME': '/home/cltbld', 04:36:19 INFO - 'LANG': 'en_US.UTF-8', 04:36:19 INFO - 'LANGUAGE': 'en_US:en', 04:36:19 INFO - 'LOGNAME': 'cltbld', 04:36:19 INFO - 'MAIL': '/var/mail/cltbld', 04:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:19 INFO - 'MOZ_NO_REMOTE': '1', 04:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:19 INFO - 'NO_EM_RESTART': '1', 04:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:19 INFO - 'PWD': '/builds/slave/test', 04:36:19 INFO - 'SHELL': '/bin/bash', 04:36:19 INFO - 'SHLVL': '1', 04:36:19 INFO - 'TERM': 'linux', 04:36:19 INFO - 'TMOUT': '86400', 04:36:19 INFO - 'USER': 'cltbld', 04:36:19 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:19 INFO - '_': '/tools/buildbot/bin/python'} 04:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:19 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:21 INFO - warning: no files found matching '*.txt' 04:36:21 INFO - no previously-included directories found matching 'build' 04:36:21 INFO - no previously-included directories found matching 'dist' 04:36:21 INFO - no previously-included directories found matching '.git*' 04:36:21 INFO - Installing collected packages: jsonschema, functools32 04:36:21 INFO - Running setup.py install for functools32 04:36:21 INFO - warning: no files found matching '*.txt' 04:36:21 INFO - no previously-included directories found matching 'build' 04:36:21 INFO - no previously-included directories found matching 'dist' 04:36:21 INFO - no previously-included directories found matching '.git*' 04:36:21 INFO - Successfully installed jsonschema functools32 04:36:21 INFO - Cleaning up... 04:36:21 INFO - Return code: 0 04:36:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:21 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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:21 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 04:36:21 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 04:36:21 INFO - Using env: {'DISPLAY': ':0', 04:36:21 INFO - 'HOME': '/home/cltbld', 04:36:21 INFO - 'LANG': 'en_US.UTF-8', 04:36:21 INFO - 'LANGUAGE': 'en_US:en', 04:36:21 INFO - 'LOGNAME': 'cltbld', 04:36:21 INFO - 'MAIL': '/var/mail/cltbld', 04:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:21 INFO - 'MOZ_NO_REMOTE': '1', 04:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:21 INFO - 'NO_EM_RESTART': '1', 04:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:21 INFO - 'PWD': '/builds/slave/test', 04:36:21 INFO - 'SHELL': '/bin/bash', 04:36:21 INFO - 'SHLVL': '1', 04:36:21 INFO - 'TERM': 'linux', 04:36:21 INFO - 'TMOUT': '86400', 04:36:21 INFO - 'USER': 'cltbld', 04:36:21 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:21 INFO - '_': '/tools/buildbot/bin/python'} 04:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:21 INFO - Cleaning up... 04:36:21 INFO - Return code: 0 04:36:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:22 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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:22 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 04:36:22 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 04:36:22 INFO - Using env: {'DISPLAY': ':0', 04:36:22 INFO - 'HOME': '/home/cltbld', 04:36:22 INFO - 'LANG': 'en_US.UTF-8', 04:36:22 INFO - 'LANGUAGE': 'en_US:en', 04:36:22 INFO - 'LOGNAME': 'cltbld', 04:36:22 INFO - 'MAIL': '/var/mail/cltbld', 04:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:22 INFO - 'MOZ_NO_REMOTE': '1', 04:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:22 INFO - 'NO_EM_RESTART': '1', 04:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:22 INFO - 'PWD': '/builds/slave/test', 04:36:22 INFO - 'SHELL': '/bin/bash', 04:36:22 INFO - 'SHLVL': '1', 04:36:22 INFO - 'TERM': 'linux', 04:36:22 INFO - 'TMOUT': '86400', 04:36:22 INFO - 'USER': 'cltbld', 04:36:22 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:22 INFO - '_': '/tools/buildbot/bin/python'} 04:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:22 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 04:36:22 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 04:36:22 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 04:36:22 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 04:36:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:23 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 04:36:23 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 04:36:23 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 04:36:23 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 04:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 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 04:36:24 INFO - Downloading docopt-0.6.1.tar.gz 04:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:24 INFO - Running setup.py install for blobuploader 04:36:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:24 INFO - Running setup.py install for requests 04:36:24 INFO - Running setup.py install for docopt 04:36:24 INFO - Successfully installed blobuploader requests docopt 04:36:24 INFO - Cleaning up... 04:36:25 INFO - Return code: 0 04:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:25 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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:25 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 04:36:25 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 04:36:25 INFO - Using env: {'DISPLAY': ':0', 04:36:25 INFO - 'HOME': '/home/cltbld', 04:36:25 INFO - 'LANG': 'en_US.UTF-8', 04:36:25 INFO - 'LANGUAGE': 'en_US:en', 04:36:25 INFO - 'LOGNAME': 'cltbld', 04:36:25 INFO - 'MAIL': '/var/mail/cltbld', 04:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:25 INFO - 'MOZ_NO_REMOTE': '1', 04:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:25 INFO - 'NO_EM_RESTART': '1', 04:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:25 INFO - 'PWD': '/builds/slave/test', 04:36:25 INFO - 'SHELL': '/bin/bash', 04:36:25 INFO - 'SHLVL': '1', 04:36:25 INFO - 'TERM': 'linux', 04:36:25 INFO - 'TMOUT': '86400', 04:36:25 INFO - 'USER': 'cltbld', 04:36:25 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:25 INFO - '_': '/tools/buildbot/bin/python'} 04:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:25 INFO - Running setup.py (path:/tmp/pip-kTucs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:25 INFO - Running setup.py (path:/tmp/pip-ByzM3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:25 INFO - Running setup.py (path:/tmp/pip-HCKYZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:25 INFO - Running setup.py (path:/tmp/pip-LVVwP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:25 INFO - Running setup.py (path:/tmp/pip-iLEu_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:25 INFO - Running setup.py (path:/tmp/pip-flHceA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:26 INFO - Running setup.py (path:/tmp/pip-HeY5Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:26 INFO - Running setup.py (path:/tmp/pip-4mT6Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:26 INFO - Running setup.py (path:/tmp/pip-23h64c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:26 INFO - Running setup.py (path:/tmp/pip-dRHEbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:26 INFO - Running setup.py (path:/tmp/pip-OiQrdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:26 INFO - Running setup.py (path:/tmp/pip-jLiioD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:26 INFO - Running setup.py (path:/tmp/pip-7MWnBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:26 INFO - Running setup.py (path:/tmp/pip-pIlsX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:26 INFO - Running setup.py (path:/tmp/pip-iRDSJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:26 INFO - Running setup.py (path:/tmp/pip-ksgRa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:26 INFO - Running setup.py (path:/tmp/pip-gHx5GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:26 INFO - Running setup.py install for manifestparser 04:36:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:26 INFO - Running setup.py install for mozcrash 04:36:27 INFO - Running setup.py install for mozdebug 04:36:27 INFO - Running setup.py install for mozdevice 04:36:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Running setup.py install for mozfile 04:36:27 INFO - Running setup.py install for mozhttpd 04:36:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Running setup.py install for mozinfo 04:36:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Running setup.py install for mozInstall 04:36:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Running setup.py install for mozleak 04:36:27 INFO - Running setup.py install for mozlog 04:36:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:27 INFO - Running setup.py install for moznetwork 04:36:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:28 INFO - Running setup.py install for mozprocess 04:36:28 INFO - Running setup.py install for mozprofile 04:36:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:28 INFO - Running setup.py install for mozrunner 04:36:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:28 INFO - Running setup.py install for mozscreenshot 04:36:28 INFO - Running setup.py install for moztest 04:36:28 INFO - Running setup.py install for mozversion 04:36:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:28 INFO - Cleaning up... 04:36:28 INFO - Return code: 0 04:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:29 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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:29 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 04:36:29 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 04:36:29 INFO - Using env: {'DISPLAY': ':0', 04:36:29 INFO - 'HOME': '/home/cltbld', 04:36:29 INFO - 'LANG': 'en_US.UTF-8', 04:36:29 INFO - 'LANGUAGE': 'en_US:en', 04:36:29 INFO - 'LOGNAME': 'cltbld', 04:36:29 INFO - 'MAIL': '/var/mail/cltbld', 04:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:29 INFO - 'MOZ_NO_REMOTE': '1', 04:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:29 INFO - 'NO_EM_RESTART': '1', 04:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:29 INFO - 'PWD': '/builds/slave/test', 04:36:29 INFO - 'SHELL': '/bin/bash', 04:36:29 INFO - 'SHLVL': '1', 04:36:29 INFO - 'TERM': 'linux', 04:36:29 INFO - 'TMOUT': '86400', 04:36:29 INFO - 'USER': 'cltbld', 04:36:29 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:29 INFO - '_': '/tools/buildbot/bin/python'} 04:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:29 INFO - Running setup.py (path:/tmp/pip-e0PIhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:29 INFO - Running setup.py (path:/tmp/pip-R62J0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:29 INFO - Running setup.py (path:/tmp/pip-cWCr7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:29 INFO - Running setup.py (path:/tmp/pip-NYbWzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:29 INFO - Running setup.py (path:/tmp/pip-KUkL1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:29 INFO - Running setup.py (path:/tmp/pip-9TrNR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:29 INFO - Running setup.py (path:/tmp/pip-8wz3YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:29 INFO - Running setup.py (path:/tmp/pip-l4vwMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:29 INFO - Running setup.py (path:/tmp/pip-rJLrQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:29 INFO - Running setup.py (path:/tmp/pip-dtjKDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:29 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)) 04:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:29 INFO - Running setup.py (path:/tmp/pip-Ba4APd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:30 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)) 04:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:30 INFO - Running setup.py (path:/tmp/pip-JaIBR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:30 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)) 04:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:30 INFO - Running setup.py (path:/tmp/pip-vaojEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:30 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)) 04:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:30 INFO - Running setup.py (path:/tmp/pip-4QdS94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:30 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)) 04:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:30 INFO - Running setup.py (path:/tmp/pip-eOc1N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:30 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)) 04:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:30 INFO - Running setup.py (path:/tmp/pip-Kx1sEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:30 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)) 04:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:30 INFO - Running setup.py (path:/tmp/pip-AAymA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:30 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)) 04:36:30 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)) 04:36:30 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)) 04:36:30 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)) 04:36:30 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)) 04:36:30 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)) 04:36:30 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)) 04:36:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:30 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 04:36:30 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 04:36:30 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 04:36:30 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 04:36:33 INFO - Downloading blessings-1.6.tar.gz 04:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:33 INFO - Installing collected packages: blessings 04:36:33 INFO - Running setup.py install for blessings 04:36:33 INFO - Successfully installed blessings 04:36:33 INFO - Cleaning up... 04:36:33 INFO - Return code: 0 04:36:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:33 INFO - Reading from file tmpfile_stdout 04:36:33 INFO - Current package versions: 04:36:33 INFO - argparse == 1.2.1 04:36:33 INFO - blessings == 1.6 04:36:33 INFO - blobuploader == 1.2.4 04:36:33 INFO - docopt == 0.6.1 04:36:33 INFO - functools32 == 3.2.3-2 04:36:33 INFO - jsonschema == 2.5.1 04:36:33 INFO - manifestparser == 1.1 04:36:33 INFO - mozInstall == 1.13 04:36:33 INFO - mozcrash == 1.0 04:36:33 INFO - mozdebug == 0.1 04:36:33 INFO - mozdevice == 0.51 04:36:33 INFO - mozfile == 1.2 04:36:33 INFO - mozhttpd == 0.7 04:36:33 INFO - mozinfo == 0.10 04:36:33 INFO - mozleak == 0.1 04:36:33 INFO - mozlog == 3.5 04:36:33 INFO - moznetwork == 0.27 04:36:33 INFO - mozprocess == 0.25 04:36:33 INFO - mozprofile == 0.28 04:36:33 INFO - mozrunner == 6.13 04:36:33 INFO - mozscreenshot == 0.1 04:36:33 INFO - mozsystemmonitor == 0.3 04:36:33 INFO - moztest == 0.8 04:36:33 INFO - mozversion == 1.4 04:36:33 INFO - psutil == 3.1.1 04:36:33 INFO - requests == 1.2.3 04:36:33 INFO - wsgiref == 0.1.2 04:36:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:34 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 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:34 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 04:36:34 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 04:36:34 INFO - Using env: {'DISPLAY': ':0', 04:36:34 INFO - 'HOME': '/home/cltbld', 04:36:34 INFO - 'LANG': 'en_US.UTF-8', 04:36:34 INFO - 'LANGUAGE': 'en_US:en', 04:36:34 INFO - 'LOGNAME': 'cltbld', 04:36:34 INFO - 'MAIL': '/var/mail/cltbld', 04:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:34 INFO - 'MOZ_NO_REMOTE': '1', 04:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:34 INFO - 'NO_EM_RESTART': '1', 04:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:34 INFO - 'PWD': '/builds/slave/test', 04:36:34 INFO - 'SHELL': '/bin/bash', 04:36:34 INFO - 'SHLVL': '1', 04:36:34 INFO - 'TERM': 'linux', 04:36:34 INFO - 'TMOUT': '86400', 04:36:34 INFO - 'USER': 'cltbld', 04:36:34 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:34 INFO - '_': '/tools/buildbot/bin/python'} 04:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 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)) 04:36:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:36:34 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 04:36:34 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 04:36:34 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 04:36:34 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 04:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:36:36 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)) 04:36:36 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)) 04:36:36 INFO - Installing collected packages: simplejson 04:36:36 INFO - Running setup.py install for simplejson 04:36:36 INFO - building 'simplejson._speedups' extension 04:36:36 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 04:36:37 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 04:36:37 INFO - Successfully installed simplejson 04:36:37 INFO - Cleaning up... 04:36:37 INFO - Return code: 0 04:36:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a99a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', '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 04:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:36:37 INFO - Using env: {'DISPLAY': ':0', 04:36:37 INFO - 'HOME': '/home/cltbld', 04:36:37 INFO - 'LANG': 'en_US.UTF-8', 04:36:37 INFO - 'LANGUAGE': 'en_US:en', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MAIL': '/var/mail/cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SHLVL': '1', 04:36:37 INFO - 'TERM': 'linux', 04:36:37 INFO - 'TMOUT': '86400', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - '_': '/tools/buildbot/bin/python'} 04:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:37 INFO - Cleaning up... 04:36:37 INFO - Return code: 0 04:36:37 INFO - Running post-action listener: _resource_record_post_action 04:36:37 INFO - Running post-action listener: _start_resource_monitoring 04:36:37 INFO - Starting resource monitoring. 04:36:37 INFO - [mozharness: 2017-08-07 11:36:37.863108Z] Finished create-virtualenv step (success) 04:36:37 INFO - [mozharness: 2017-08-07 11:36:37.863617Z] Running install step. 04:36:37 INFO - Running pre-action listener: _resource_record_pre_action 04:36:37 INFO - Running main action method: install 04:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:38 INFO - Reading from file tmpfile_stdout 04:36:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:38 INFO - Reading from file tmpfile_stdout 04:36:38 INFO - Output received: 04:36:38 INFO - Usage: mozinstall [options] installer 04:36:38 INFO - Options: 04:36:38 INFO - -h, --help show this help message and exit 04:36:38 INFO - -d DEST, --destination=DEST 04:36:38 INFO - Directory to install application into. [default: 04:36:38 INFO - "/builds/slave/test"] 04:36:38 INFO - --app=APP Application being installed. [default: firefox] 04:36:38 INFO - mkdir: /builds/slave/test/build/application 04:36:38 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'] 04:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:36:56 INFO - Reading from file tmpfile_stdout 04:36:56 INFO - Output received: 04:36:56 INFO - /builds/slave/test/build/application/firefox/firefox 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - [mozharness: 2017-08-07 11:36:56.106681Z] Finished install step (success) 04:36:56 INFO - [mozharness: 2017-08-07 11:36:56.106934Z] Running setup-mitmproxy step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running main action method: setup_mitmproxy 04:36:56 INFO - Skipping: mitmproxy is not required 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - [mozharness: 2017-08-07 11:36:56.108062Z] Finished setup-mitmproxy step (success) 04:36:56 INFO - [mozharness: 2017-08-07 11:36:56.108280Z] Running run-tests step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running pre-action listener: _set_gcov_prefix 04:36:56 INFO - Running main action method: run_tests 04:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:56 INFO - Python 2.7.3 04:36:56 INFO - Return code: 0 04:36:56 INFO - grabbing minidump binary from tooltool 04:36:56 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')]} 04:36:56 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 0x2c39eb0>, '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 0x2c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:56 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 04:36:56 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 04:36:56 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 04:36:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:56 INFO - Return code: 0 04:36:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:36:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:56 INFO - ENV: RUST_BACKTRACE is now 1 04:36:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:36:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 04:36:56 INFO - Using env: {'DISPLAY': ':0', 04:36:56 INFO - 'HOME': '/home/cltbld', 04:36:56 INFO - 'LANG': 'en_US.UTF-8', 04:36:56 INFO - 'LANGUAGE': 'en_US:en', 04:36:56 INFO - 'LOGNAME': 'cltbld', 04:36:56 INFO - 'MAIL': '/var/mail/cltbld', 04:36:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:56 INFO - 'MOZ_NO_REMOTE': '1', 04:36:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:56 INFO - 'NO_EM_RESTART': '1', 04:36:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:56 INFO - 'PWD': '/builds/slave/test', 04:36:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:56 INFO - 'RUST_BACKTRACE': '1', 04:36:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:36:56 INFO - 'SHELL': '/bin/bash', 04:36:56 INFO - 'SHLVL': '1', 04:36:56 INFO - 'STYLO_FORCE_ENABLED': '1', 04:36:56 INFO - 'TERM': 'linux', 04:36:56 INFO - 'TMOUT': '86400', 04:36:56 INFO - 'USER': 'cltbld', 04:36:56 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184', 04:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:56 INFO - '_': '/tools/buildbot/bin/python'} 04:36:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 04:36:56 INFO - mozversion application_buildid: 20170807105046 04:36:56 INFO - mozversion application_changeset: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 04:36:56 INFO - mozversion application_display_name: Nightly 04:36:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:56 INFO - mozversion application_name: Firefox 04:36:56 INFO - mozversion application_remotingname: firefox 04:36:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:36:56 INFO - mozversion application_vendor: Mozilla 04:36:56 INFO - mozversion application_version: 57.0a1 04:36:56 INFO - mozversion platform_buildid: 20170807105046 04:36:56 INFO - mozversion platform_changeset: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 04:36:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:36:56 INFO - mozversion platform_version: 57.0a1 04:36:56 INFO - using testdate: 1502105816 04:36:56 INFO - actual date: 1502105816 04:36:56 INFO - starting webserver on 'localhost:56746' 04:36:56 INFO - SUITE-START | Running 2 tests 04:36:56 INFO - TEST-START | dromaeo_css 04:36:56 INFO - Initialising browser for dromaeo_css test... 04:36:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56746/getInfo.html -profile /tmp/tmpaWlQlO/profile 04:36:56 INFO - TEST-INFO | started process 5543 (/builds/slave/test/build/application/firefox/firefox http://localhost:56746/getInfo.html) 04:37:02 INFO - TEST-INFO | 5543: exit 0 04:37:02 INFO - Browser initialized. 04:37:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:02 INFO - TEST-INFO | started process 5769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaWlQlO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:03 INFO - PID 5769 | 04:37:03 INFO - PID 5769 | (/builds/slave/test/build/application/firefox/firefox:5823): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:37:03 INFO - PID 5769 | 04:37:13 INFO - PID 5769 | RSS: Main: 173191168 04:37:13 INFO - PID 5769 | 04:37:13 INFO - PID 5769 | serialization: Helvetica 04:37:13 INFO - PID 5769 | serialization: Arial 04:40:13 INFO - PID 5769 | Cycle 1(1): loaded http://localhost:56746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56746/tests/dromaeo/cssquery-ext.html) 04:40:14 INFO - PID 5769 | RSS: Main: 174792704 04:40:14 INFO - PID 5769 | 04:40:14 INFO - PID 5769 | serialization: Helvetica 04:40:14 INFO - PID 5769 | serialization: Arial 04:43:16 INFO - PID 5769 | Cycle 1(1): loaded http://localhost:56746/tests/dromaeo/cssquery-ext.html (next: http://localhost:56746/tests/dromaeo/cssquery-jquery.html) 04:43:17 INFO - PID 5769 | RSS: Main: 172945408 04:43:17 INFO - PID 5769 | 04:43:17 INFO - PID 5769 | serialization: Helvetica 04:43:17 INFO - PID 5769 | serialization: Arial 04:46:19 INFO - PID 5769 | Cycle 1(1): loaded http://localhost:56746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56746/tests/dromaeo/cssquery-mootools.html) 04:46:19 INFO - PID 5769 | RSS: Main: 174149632 04:46:19 INFO - PID 5769 | 04:46:19 INFO - PID 5769 | serialization: Helvetica 04:46:19 INFO - PID 5769 | serialization: Arial 04:49:21 INFO - PID 5769 | Cycle 1(1): loaded http://localhost:56746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56746/tests/dromaeo/cssquery-prototype.html) 04:49:22 INFO - PID 5769 | RSS: Main: 172974080 04:49:22 INFO - PID 5769 | 04:49:22 INFO - PID 5769 | serialization: Helvetica 04:49:22 INFO - PID 5769 | serialization: Arial 04:52:25 INFO - PID 5769 | Cycle 1(1): loaded http://localhost:56746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56746/tests/dromaeo/cssquery-yui.html) 04:52:26 INFO - PID 5769 | RSS: Main: 174743552 04:52:26 INFO - PID 5769 | 04:52:26 INFO - PID 5769 | serialization: Helvetica 04:52:26 INFO - PID 5769 | serialization: Arial 04:55:28 INFO - PID 5769 | Cycle 1(1): loaded http://localhost:56746/tests/dromaeo/cssquery-yui.html (next: http://localhost:56746/tests/dromaeo/cssquery-dojo.html) 04:55:28 INFO - PID 5769 | RSS: Main: 176877568 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | __start_tp_report 04:55:28 INFO - PID 5769 | _x_x_mozilla_page_load 04:55:28 INFO - PID 5769 | _x_x_mozilla_page_load_details 04:55:28 INFO - PID 5769 | |i|pagename|runs| 04:55:28 INFO - PID 5769 | |0;dojo.html;3164.2089477630607;3181.013885695434;3199.6320423151315;3204.3911656785217;3253.918652033699;6192.814215573529;6276.246850377961;6332.9683351583235;6344.1752572165615;6345.270293916201;6139.140520327158;6244.750209991595;6252.499800015999;6275.497960163188;6305.968470157654;5692.146178073281;5728.369879313273;5740.138979153139;5761.107028410603;5768.39431859655;5756.165356023374;5769.624974376673;5771.653700777946;5775.3358363788075;5777.971110144465;5769.221155144065;5774.5091667208335;5792.594518383715;5793.5365170786445;5800.506956908668;5763.596548241625;5765.682887441189;5769.07694768835;5769.076947688392;5770.422957704238;5709;5743.856403589902;5788.507976821933;5807.041838096709;5891.322497912752;6105.511559075263;6118.204633397674;6229.3459186785185;6251.062340648894;6261.373862613747;6670.599764014126;6677.232118306409;6685.465162786965;6702.195736511601;6706;6735.696893639798;6809.421199198074;6812.62530560819;6826.419754320888;6849.794506164823;6247.593906396115;6255.530835187379;6337.397947195055;6349.809505714836;6354.17395738551;6884.173899132136;6884.65576721162;6988.965055174692;7005.859882802315;7008.088948436671;6486.708098135595;6496.123023391876;6567.080608714784;6569.868602627921;6578.407943285031;6598.571092878948;6631.436327912182;6649.567778094505;6677.532572719863;6778.254392016875;6711.932880671228;6715.294894036154;6730.8653826924165;6753.8649227015185;6795.796126116125;6640.568363056386;6646.069550262967;6706.530542861953;6769.356911093439;6848.3494068063455;5389.7035663038905;5438.102713052381;5466.125419932871;5537.58468114893;5553.028220061473;4680.695754775928;4712.787924543404;4752.619790416758;4763.976180119077;4771.045790841846;5797.507211887037;5815.185873977646;5876.206712093898;5892.646441213541;5904.586678932519;6725.562838415487;6736.629485378253;6803.421709154777;6818.454523638097;6835.213950395669;5735.541156707453;5791.594588378773;5798.59409841307;5842.59101862874;5869.941300586939;5975.492083172892;6001.5798894077;6008.399160084044;6010.819675409657;6030.849228769228;6401.1678481798;6501.382368675063;6580.539362244693;6597.274299827015;6602.1747281589805;6684.364985326386;6709.597424154371;6737.3599508046655;6781.593104413751;6802;6459.063435801689;6480.740770369132;6576.539642224999;6601.801945941629;6611.438027767694;6517.989711594711;6579.4736421085245;6583.111279977142;6586.341365863375;6619.3049729779605;6715.093462382516;6716.462682985447;6733.966330168318;6803.013563033233;6817.965910170616;6526.608403495616;6589.209294884645;6590.967045164935;6598.274189839018;6598.472122230114;6466.741330346922;6501.674916254263;6514.348565143448;6586.967065164644;6589.209294884645;6326.588771729823;6432.260290066515;6451.870962580816;6486.05952136947;6537.1174891389055;6493.4155925965;6529.4776417885505;6582.80251592453;6591.538592298493;6592.406683398517;6316.905246421399;6383.457406120346;6384.93615063862;6397.6481293529305;6399.840003999937 04:55:28 INFO - PID 5769 | |1;ext.html;806.9636866341018;856.503228127686;882.8763973043775;885.0618344554772;1150.131650603794;30965.69034309656;31503;42821.785891070576;43530;43634.34548481775;43822.34266486005;44298.33552496715;44305.556944430544;44436;44472.77763611177;7354;7754.302112809846;7864.056313242419;7964.5619490927975;7983.401244906655;7752.806179845521;7846.176151504095;7884.053913530356;7886.566238856861;7888.842223155533;7881.330086942617;7905.644246008944;7912.248336408032;7927.40544459165;7947.960260198691;7747.2640099190485;7776.222377762207;7811.648475818602;7820.921790782077;7846.215378462165;7737.8452430951065;7803;7819.765407037741;7832.804179895491;7838.37293016563;40247.7987610063;40541.39187912184;40596.79701601503;40639.18721625551;40718.38922416166;3573.731970102253;3598.1364472526407;3612.5123108380294;3640.071781695677;3651.835667394974;31834;31862;31990.360192796015;32021.679783202104;32044;4887.291342755316;5034.924476132861;5074.3657042869645;5079.3650793650795;5089.41471730752;185782;186004;186485;187015;187294;49782.50217497851;49807.750961244965;49810.50189498131;49846.75076624594;49921.75039124781;51417;51418;51461.74269128705;51481.742591286806;51559;16065.919670401574;16294.755578666329;16382.098984555725;16389.590260243353;16402.753958690628;11118.332900026024;11379.089672826154;13355.332233388486;13420.597382078553;13549.25479098659;14475;14527.636809079646;14561.854381456262;14673.119612823264;14717.19055451939;5816.796412125555;5898.734556944948;5944.464998150101;5948.078047902582;5950.583459157818;997.4464172384396;1024.329064462778;1027.9331843430152;1028.7890982348601;1035.668586052456;22934.541309173725;23049.847507624552;23123.76876231216;23130;23246.76753232446;1085.7014321061772;1105.9778804424027;1113.3153110836777;1117.4412793603199;1130.5421304371744;12216.26702397859;12363.258204507758;12440.81812227837;12493.625191244277;12582.18215815969;235239;239012;239048;239077;239587;54508.18237726437;54757;54911.17633235505;55330.446695533334;55330.72334638381;1475.5942115917994;1480.0897448069575;1516.0221657031373;1518.4229992602961;1524.7560390337492;22310.442238944157;22483.775162248166;22752.20367287137;22856.200032998764;23172.073117075128;39305;39453.01367465837;39471.802640986614;39476.605233947295;39508.2098358037;199806;199874;199951;200210;200773;34833.47749783705;35408.29183416369;38788;39674.2065158701;39696;48884.51115488942;49134;49354.25968610402;49482.50517494923;49653;34909;35275.82362088173;35328.823355883054;35564.288714225055;35734;34475.31049378948;34944;35230.97201973153;35355;35821;38521.36981668752;38690.613093869826;38803.02992425212;38986.2202755949;39019.41470877882;33371.666283336854;33637.66362336443;33706.15734606556;33720.49419258664;33811;24737.50524989526;25141.49717005613;25346.619800703374;25828.741712582632;25845.353866153495 04:55:28 INFO - PID 5769 | |2;jquery.html;585.5608293779666;588.629163626915;590.8168467774992;598.7694737526052;603.2851071480295;22789.772102278974;22818.771812281873;23655.763442365573;23843.880780596093;23926.04295828167;26280.605790913105;27067.729322706768;27102.5934610981;27106.864465677645;27131.45737085257;6625.602463852172;6728;6733.259341472434;6760.898586521206;6796.592204467748;6206.441420272175;6482.578632388903;6508.511861610375;6569.901451478232;6676.666166691671;6440;6456.774012909549;6467.029945508164;6493.480521558264;6507.056476810883;6403.96798016007;6455.5158363122955;6465.739180859734;6472.90290645643;6479.708413121421;6019.856227316795;6020.6688632125215;6026.668533230671;6050.152978583002;6050.27396712393;29075.273118172005;29751.107466776033;30390;30775;30784.846075769477;1933.0528041259822;1943.5529828139465;1954.6090781843545;1961.225316000172;1967.3507742444958;19199.520011999673;19412.320568780025;20249.190032398685;20272.189112435484;20332.5933481331;2495.3262619092925;2507.109975958545;2533.518631460017;2540.5554028045017;2546.752091475182;143690;145325.27337363246;147739;149187;156461.21769391195;14989.250537473083;15052.54842354731;15078.596736364134;15151.696966060617;15588.129424468909;24069.638955415332;24155.75844241535;24176.274711758677;24185.15351962673;24261.51476970486;9708.368956017835;9936.701898943043;9940.403575785476;10141.442220677785;10649.414282214397;8914;8925.73222803317;8931.73204803857;9044.186023257938;9049.276057915351;7816.7264145754625;9467.621295148117;9656.27577931658;9691.07934746198;9813.754656133653;2877.956830647542;2912.257374369565;2934.163763327484;2942.4556457055087;2976.4493568689427;940.4404329612521;968.8740463739668;976.3897564022486;978.8874279457954;983.2822039910905;19720;19979.400617981482;20228.898855505628;20293.797062029487;20457.38627841167;1030.845373194027;1032.8192566300868;1046.5552140340326;1052.5053224984244;1056.6090546497692;11009.339439633648;11133.220674552866;11156.442177891073;11166.497507612177;11192.664220073411;441348;458391;482570;487068;487818;117330.41334793271;118952.40523797326;121102;121765;122960;1235.5552001279532;1252.5553428532921;1300.057458342694;1303.7262174943369;1304.3217526886156;20834.58330833405;20965.161393544087;21075.26236581712;21398.53916799588;21531.354059378245;54183;54333;55746.16380754211;56031.43968560262;57537.42462575321;69896.65051674913;70164;70188.29811701817;70238.64880675563;71161;14806.62983425423;14938.253087345372;14989.325480353193;14992.925035374754;15001.624959376102;21590.892045539673;22055.889720551295;23638.64542031905;23847.761522384553;23907.641385379582;18078.638427231646;18447.631047379247;18660.2535898568;18802.34191803335;18816.341428049953;16934.915325423786;17099.48701538906;17103.401380951607;17261.309547618457;17524.73712894282;18254.817451825842;19120.80879191246;19266.903665481583;19313.90343048276;19609;14792.704145917236;14849.257537123316;14993.550193494213;14995.2502374883;15020.92489537589;17732.91133544324;18818.059097045367;18967.620647587246;19073.237070517025;19236 04:55:28 INFO - PID 5769 | |3;mootools.html;1319.7822359310712;1351.9526816561422;1355.4307190979787;1363.059488952622;1384.1625816381086;11966.700832479171;13689.452421903125;14244;14279.2860356982;14283.78574321386;11778.411079446016;13424.463021479154;13776.724465510684;13844.792328115087;13848;2663.6404085448507;2742.1362270884606;2743.7667798237176;2747.175847245818;2748.8625568721486;2636.894524219029;2684.127658510982;2696.8651567421552;2701.783857291412;2708.444768822387;2671.9732802672015;2718.415540658758;2722.2105589379057;2722.8774705138217;2722.9591556126675;2577.072253988563;2583.638290639303;2597.052075992259;2601.7398260174023;2603.5313643544155;2508.5108403861254;2539.6444497770326;2542.834715743489;2555.859427731474;2557.2583950654475;13429.39567719455;13650.658733531642;13668;13691.315434228249;13708.725825483434;7613.961930190369;7957.124716281204;7958.562279074648;7973.162817904153;7977.16239794819;4938.3580134582635;5090.490950904917;5152.201408781645;5301.1783173608155;5311.893762124736;1762.5064981804987;1764.9647007059787;1803.2696757813108;1820.1445320699384;1839.448165550343;22903.19838805634;22907;22981.54036919269;22983.88508057466;23024;6624.171978502687;6937.271586483447;7026.859462810715;7113.110861142357;7180.425565954711;18490.260389584266;18538.25846966106;18564.164612592467;18605.441836744918;18610.348637797884;7800.92199078002;7941.285284324438;7979.441439099207;8282.544460054754;8314.958425207835;7141.357277844915;7318.926810731931;7360.926390736024;7390.224026477143;7399;5006.148954677714;5130.384353877558;5147.613928955343;5167.044096842021;5190.11767999441;1503.158231390403;1545.1424459424902;1552.767084937246;1558.789563408948;1575.487966410921;888.3426264564176;913.2511340700562;915.8031023330016;921.8478950973148;926.3885835348638;7402.444816638774;7438.4049276057785;7440.181580026193;7470.663820128108;7604.771856844303;721.0806222066907;723.2622724820653;727.7052793618593;730.6456368661195;735.3161559749377;4888.755562221874;5199.688018718889;5243.947560524422;5270;5361.946380536223;19250.80749192518;19496.31762888292;19739.605207895762;19744.60510789805;19937.202511899653;18937;19449.22203111888;19501.804981949997;19678.508037299183;19920.203191872453;10773.838392423962;10782.137429005661;10863.076638485818;10886.510107045202;10895.509702063426;7791.532508049535;7916.643751031333;8502.659893604186;8771.824563508822;8902.332325075517;16517.752233716263;16563;17023.23395447183;17112.657746844743;17552.648947020734;17588.29646814164;17665.646687065928;17699.82300177033;17707.46877593674;17807.91096044563;11300.49147788335;11357.829632555353;11623.12826537996;11660.30038197711;11664.475098620413;13053.738925221633;13062.673433164247;13069.803952940523;13108.475660973454;13118.672033199246;10462.895371046192;10464.424456654957;10931.180161488079;11079.279846809932;11133.220674552704;9839.85240221383;10024.097831195228;10251.48742562854;10282.228832837418;10400.115990140923;8571.100034496289;8616.741497755078;8675.262602678842;8685.392022558613;8688.304935605263;7095.538789978635;7187.209406965334;7244.492885497964;7324.121105467378;7427.925720742724;7227.27727227273;7242.52923559988;7363.852722945404;7375.668094935848;7437.776866694008 04:55:28 INFO - PID 5769 | |4;prototype.html;490.43090568454016;508.6464906889711;521.3587287636208;533.0012453300125;533.8905524367505;6271.341509141537;6319.431251187387;6325.683715814214;6346.587471814329;6350;6206.937930620692;6242.375762423755;6259.499240060795;6273.278572964111;6303.55875088744;5127.948720512803;5172.120739474289;5196.350456192976;5206.7656955436905;5225.8954820903555;4812.157872372339;5092;5122.871928201806;5127.230915362707;5147.202183661539;4863.562279394854;4902.166631672624;4914.877128071809;4929.126931765942;4959.677620954644;4871.4397844248015;4885.5114488551035;4885.584725298354;4890.853274401774;4903.387076615423;4347.087111706545;4415.050764085705;4453.376527286183;4456.799444025027;4475.239209334421;5908.320543137551;5978.192943952554;6007.789727359522;6013.789517366915;6073.635581865102;5664.518515926151;5689.9146512802345;5695.572832037572;5709.200711900337;5736.512396446307;6549.214094308666;6593.076969224312;6594.911839546517;6628.4697224221945;6656.434203092695;4882.194437917739;4885.902281954376;4915.926261106087;4915.950840491585;4949.851504454872;6604.636744979072;6645.501587380917;6758.8310292242595;6762.492813038993;6793.864122717568;4915.16442204826;4922.310876477296;4936.605071594336;4965.977558177888;5025.271335656383;4989.501049895054;5020.924686129711;5042.697438153649;5086.440491546001;5132.8460146195675;5580.246666700024;5597.216389705363;5646.520045796071;5666.178404131378;5679.204911312419;6528.2166140062545;6528.477721782246;6535.44448721864;6576.605403675795;6601.788400885757;1771.2737777511159;1772.9556761081076;1775.7336399539913;1785.8839175453554;1797.3709201779272;1171.221137943258;1220.664317312746;1223.7552489501957;1238.4365113873166;1244.9626511204679;5728.914066289009;5764.279465066867;5767.798127065616;5822.700033486749;5837.532997360201;6695.732170713117;6719.529632925746;6732.629705366154;6741.764038258735;6791.524593278423;5690.7439165237665;5728.656280623176;5742.425757424224;5786.537077033911;5812.157237200582;3565.8038807865814;3597.2625611749527;3606.1165014571598;3608.5850127235703;3612.8735494257576;6451.870962580722;6490.545661803629;6509.707063182168;6510.153680021567;6574.022716256596;6802.8299292517095;6829.556078854858;6836.350546698056;6865.794026179223;6912.965435172892;6440.420362167428;6476.158099447041;6493.31820158886;6509.381608747256;6528.249251336157;6187.412195841388;6537.934620653923;6660.900086498609;6694.933050669431;6714.597124172566;6554.868902622016;6603.405693487609;6617.834554135992;6650.600963942179;6651.235107962646;6368.713407896563;6391.10524526576;6392.561673623398;6470.158879345843;6510.44661203803;5012.423571289349;5021.342956824166;5028.6674031382445;5055.595552355876;5077.543021128116;6520.217573891164;6643.966780166068;6712.295209002984;6757.797266082025;6762.039008687426;6296.118543403835;6458.22501299847;6524.641144737085;6554.705038273384;6559.901601476077;6448.451881590117;6476.255230648348;6530.640814755234;6535.3137920517665;6547.70535325902;6361.840953976188;6423.261324947691;6443.329869714621;6465.127207826883;6525.3800888915475;6539.280679125388;6612.768553100618;6627.204735431586;6651.268360480247;6656.633885136364;6256.217972753406;6339.366063393808;6371.745130194926;6476.514261430318;6483 04:55:28 INFO - PID 5769 | |5;yui.html;891.5319457284928;899.4018977380042;918.5774543709894;926;927.0497739816687;19161.329353472633;20313.18747250112;20406;20415.591688166227;20423.080961356736;21035.263765768203;21940.341789746333;21951.560968780614;22062.779372206274;22201.11195552176;1007.6322142418002;1023.2376879224988;1031.437866362834;1036.9429681367521;1038.112413886124;599.4814485470059;616.9167162433059;1019.6176433837311;1026.2508368890676;1041.7499800047972;1077.665923563694;1089.9073578745815;1093.5079214353532;1093.928894621851;1095.3865835132312;1070.0476575847501;1083.7236504691293;1087.0271107358908;1087.1846115413439;1087.690008347625;787.5392895156341;792.6393490961599;795.6021989005498;798.62863768348;800.2357748350312;20119.39641810748;20489.180432782672;20507.794922050885;20552.794472055237;20727.378178654664;20445;20796.856172910484;20844.27045053431;20914.37256882296;20953.05711242998;16205.91897040519;16252.024878507327;16465.25906334218;16518.2566784495;16649;3648.452732090181;3659.5974442811535;3662.688671462929;3666.6699997000132;3678.411454167347;123983;125282;125597;127585.36207318904;129946;16406.261718222708;16535.338586456648;16809.159542023095;16824.74762878558;16976.236069376908;30473.933412330905;31397.52903706446;31442.528362074587;31616.683833161835;31646.367072658417;8404.369672274604;8575.914240857637;8665.523396213142;8673.089325620846;8673.696420625374;4265.210935976854;4298.118885628502;4353.477582690098;4371.235033869124;4388.341748737651;5296.523312901857;5409.080456322435;5411.269478620415;5411.540019098421;5420.349558053059;1082.767205050902;1110.123002827757;1120.1430905357408;1129.0290350298737;1129.88701129888;567.1804242869097;582.6300299309969;589.5136512377306;598.9730462129214;609.3723464831231;10733.731656708489;10838.078763305208;11155;11233.606823761129;11400.657980260605;516.4267662894184;526.4866754914004;551.310861423221;578.2251782611321;587.3275100010464;4680.859574212779;5460.235567020621;5481.123020316731;5566.248556444909;5697.4587414195585;101993.49003254937;102168;102375.4881225589;102536;104387;90497;90693;90898;96103.51948240215;96347;80763;82107.5894620523;83797.58101209455;85421;85836.14163858406;11280.7743845121;11287.7742445149;11457.885421145682;11468.254563453349;11636.36000020007;36134.27731445304;37591.060223494635;38037;38605.22789544137;38631.42052869153;63247.05129423155;65035.67482162559;65775.34224657693;68796.312036879;69248.3075169262;13619;14118.858811411754;14265.144091354552;14291.213983231022;14447.422103115758;17970;18047.368342107962;18197.909010454863;18401.079946002916;18514.44456666302;15347.155906425254;15428.382864685287;15443.150626715638;15460;15600.84399155994;16875.156242188088;16899.070551119315;16947.32210711558;16959.491215263562;17079.914600426917;16799.74800377971;16814.411495597597;16903.915480422518;17306.13469326554;17351.7397239039;10798.838017429587;10926.399048052115;11013.504392302526;11024;11371.772564548828;12570.308633025272;12600.74798504043;12884.742305154032;13054.477820887438;13103.475860965455 04:55:28 INFO - PID 5769 | __end_tp_report 04:55:28 INFO - PID 5769 | __start_cc_report 04:55:28 INFO - PID 5769 | _x_x_mozilla_cycle_collect,385 04:55:28 INFO - PID 5769 | __end_cc_report 04:55:28 INFO - PID 5769 | __startTimestamp1502106928566__endTimestamp 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | ------- Summary: start ------- 04:55:28 INFO - PID 5769 | Number of tests: 6 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | [#0] dojo.html Cycles:165 Average:6198.04 Median:6432.26 stddev:717.07 (11.1%) stddev-sans-first:678.63 04:55:28 INFO - PID 5769 | Values: 3164.2 3181.0 3199.6 3204.4 3253.9 6192.8 6276.2 6333.0 6344.2 6345.3 6139.1 6244.8 6252.5 6275.5 6306.0 5692.1 5728.4 5740.1 5761.1 5768.4 5756.2 5769.6 5771.7 5775.3 5778.0 5769.2 5774.5 5792.6 5793.5 5800.5 5763.6 5765.7 5769.1 5769.1 5770.4 5709.0 5743.9 5788.5 5807.0 5891.3 6105.5 6118.2 6229.3 6251.1 6261.4 6670.6 6677.2 6685.5 6702.2 6706.0 6735.7 6809.4 6812.6 6826.4 6849.8 6247.6 6255.5 6337.4 6349.8 6354.2 6884.2 6884.7 6989.0 7005.9 7008.1 6486.7 6496.1 6567.1 6569.9 6578.4 6598.6 6631.4 6649.6 6677.5 6778.3 6711.9 6715.3 6730.9 6753.9 6795.8 6640.6 6646.1 6706.5 6769.4 6848.3 5389.7 5438.1 5466.1 5537.6 5553.0 4680.7 4712.8 4752.6 4764.0 4771.0 5797.5 5815.2 5876.2 5892.6 5904.6 6725.6 6736.6 6803.4 6818.5 6835.2 5735.5 5791.6 5798.6 5842.6 5869.9 5975.5 6001.6 6008.4 6010.8 6030.8 6401.2 6501.4 6580.5 6597.3 6602.2 6684.4 6709.6 6737.4 6781.6 6802.0 6459.1 6480.7 6576.5 6601.8 6611.4 6518.0 6579.5 6583.1 6586.3 6619.3 6715.1 6716.5 6734.0 6803.0 6818.0 6526.6 6589.2 6591.0 6598.3 6598.5 6466.7 6501.7 6514.3 6587.0 6589.2 6326.6 6432.3 6451.9 6486.1 6537.1 6493.4 6529.5 6582.8 6591.5 6592.4 6316.9 6383.5 6384.9 6397.6 6399.8 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | [#1] ext.html Cycles:180 Average:38647.42 Median:3605.32 stddev:54312.35 (1506.4%) stddev-sans-first:54390.38 04:55:28 INFO - PID 5769 | Values: 807.0 856.5 882.9 885.1 1150.1 30965.7 31503.0 42821.8 43530.0 43634.3 43822.3 44298.3 44305.6 44436.0 44472.8 7354.0 7754.3 7864.1 7964.6 7983.4 7752.8 7846.2 7884.1 7886.6 7888.8 7881.3 7905.6 7912.2 7927.4 7948.0 7747.3 7776.2 7811.6 7820.9 7846.2 7737.8 7803.0 7819.8 7832.8 7838.4 40247.8 40541.4 40596.8 40639.2 40718.4 3573.7 3598.1 3612.5 3640.1 3651.8 31834.0 31862.0 31990.4 32021.7 32044.0 4887.3 5034.9 5074.4 5079.4 5089.4 185782.0 186004.0 186485.0 187015.0 187294.0 49782.5 49807.8 49810.5 49846.8 49921.8 51417.0 51418.0 51461.7 51481.7 51559.0 16065.9 16294.8 16382.1 16389.6 16402.8 11118.3 11379.1 13355.3 13420.6 13549.3 14475.0 14527.6 14561.9 14673.1 14717.2 5816.8 5898.7 5944.5 5948.1 5950.6 997.4 1024.3 1027.9 1028.8 1035.7 22934.5 23049.8 23123.8 23130.0 23246.8 1085.7 1106.0 1113.3 1117.4 1130.5 12216.3 12363.3 12440.8 12493.6 12582.2 235239.0 239012.0 239048.0 239077.0 239587.0 54508.2 54757.0 54911.2 55330.4 55330.7 1475.6 1480.1 1516.0 1518.4 1524.8 22310.4 22483.8 22752.2 22856.2 23172.1 39305.0 39453.0 39471.8 39476.6 39508.2 199806.0 199874.0 199951.0 200210.0 200773.0 34833.5 35408.3 38788.0 39674.2 39696.0 48884.5 49134.0 49354.3 49482.5 49653.0 34909.0 35275.8 35328.8 35564.3 35734.0 34475.3 34944.0 35231.0 35355.0 35821.0 38521.4 38690.6 38803.0 38986.2 39019.4 33371.7 33637.7 33706.2 33720.5 33811.0 24737.5 25141.5 25346.6 25828.7 25845.4 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | [#2] jquery.html Cycles:180 Average:34908.83 Median:23916.84 stddev:80247.30 (335.5%) stddev-sans-first:80431.04 04:55:28 INFO - PID 5769 | Values: 585.6 588.6 590.8 598.8 603.3 22789.8 22818.8 23655.8 23843.9 23926.0 26280.6 27067.7 27102.6 27106.9 27131.5 6625.6 6728.0 6733.3 6760.9 6796.6 6206.4 6482.6 6508.5 6569.9 6676.7 6440.0 6456.8 6467.0 6493.5 6507.1 6404.0 6455.5 6465.7 6472.9 6479.7 6019.9 6020.7 6026.7 6050.2 6050.3 29075.3 29751.1 30390.0 30775.0 30784.8 1933.1 1943.6 1954.6 1961.2 1967.4 19199.5 19412.3 20249.2 20272.2 20332.6 2495.3 2507.1 2533.5 2540.6 2546.8 143690.0 145325.3 147739.0 149187.0 156461.2 14989.3 15052.5 15078.6 15151.7 15588.1 24069.6 24155.8 24176.3 24185.2 24261.5 9708.4 9936.7 9940.4 10141.4 10649.4 8914.0 8925.7 8931.7 9044.2 9049.3 7816.7 9467.6 9656.3 9691.1 9813.8 2878.0 2912.3 2934.2 2942.5 2976.4 940.4 968.9 976.4 978.9 983.3 19720.0 19979.4 20228.9 20293.8 20457.4 1030.8 1032.8 1046.6 1052.5 1056.6 11009.3 11133.2 11156.4 11166.5 11192.7 441348.0 458391.0 482570.0 487068.0 487818.0 117330.4 118952.4 121102.0 121765.0 122960.0 1235.6 1252.6 1300.1 1303.7 1304.3 20834.6 20965.2 21075.3 21398.5 21531.4 54183.0 54333.0 55746.2 56031.4 57537.4 69896.7 70164.0 70188.3 70238.6 71161.0 14806.6 14938.3 14989.3 14992.9 15001.6 21590.9 22055.9 23638.6 23847.8 23907.6 18078.6 18447.6 18660.3 18802.3 18816.3 16934.9 17099.5 17103.4 17261.3 17524.7 18254.8 19120.8 19266.9 19313.9 19609.0 14792.7 14849.3 14993.6 14995.3 15020.9 17732.9 18818.1 18967.6 19073.2 19236.0 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | [#3] mootools.html Cycles:180 Average:8799.85 Median:2590.35 stddev:6039.21 (233.1%) stddev-sans-first:6029.99 04:55:28 INFO - PID 5769 | Values: 1319.8 1352.0 1355.4 1363.1 1384.2 11966.7 13689.5 14244.0 14279.3 14283.8 11778.4 13424.5 13776.7 13844.8 13848.0 2663.6 2742.1 2743.8 2747.2 2748.9 2636.9 2684.1 2696.9 2701.8 2708.4 2672.0 2718.4 2722.2 2722.9 2723.0 2577.1 2583.6 2597.1 2601.7 2603.5 2508.5 2539.6 2542.8 2555.9 2557.3 13429.4 13650.7 13668.0 13691.3 13708.7 7614.0 7957.1 7958.6 7973.2 7977.2 4938.4 5090.5 5152.2 5301.2 5311.9 1762.5 1765.0 1803.3 1820.1 1839.4 22903.2 22907.0 22981.5 22983.9 23024.0 6624.2 6937.3 7026.9 7113.1 7180.4 18490.3 18538.3 18564.2 18605.4 18610.3 7800.9 7941.3 7979.4 8282.5 8315.0 7141.4 7318.9 7360.9 7390.2 7399.0 5006.1 5130.4 5147.6 5167.0 5190.1 1503.2 1545.1 1552.8 1558.8 1575.5 888.3 913.3 915.8 921.8 926.4 7402.4 7438.4 7440.2 7470.7 7604.8 721.1 723.3 727.7 730.6 735.3 4888.8 5199.7 5243.9 5270.0 5361.9 19250.8 19496.3 19739.6 19744.6 19937.2 18937.0 19449.2 19501.8 19678.5 19920.2 10773.8 10782.1 10863.1 10886.5 10895.5 7791.5 7916.6 8502.7 8771.8 8902.3 16517.8 16563.0 17023.2 17112.7 17552.6 17588.3 17665.6 17699.8 17707.5 17807.9 11300.5 11357.8 11623.1 11660.3 11664.5 13053.7 13062.7 13069.8 13108.5 13118.7 10462.9 10464.4 10931.2 11079.3 11133.2 9839.9 10024.1 10251.5 10282.2 10400.1 8571.1 8616.7 8675.3 8685.4 8688.3 7095.5 7187.2 7244.5 7324.1 7427.9 7227.3 7242.5 7363.9 7375.7 7437.8 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | [#4] prototype.html Cycles:180 Average:5504.52 Median:6197.18 stddev:1534.43 (24.8%) stddev-sans-first:1491.87 04:55:28 INFO - PID 5769 | Values: 490.4 508.6 521.4 533.0 533.9 6271.3 6319.4 6325.7 6346.6 6350.0 6206.9 6242.4 6259.5 6273.3 6303.6 5127.9 5172.1 5196.4 5206.8 5225.9 4812.2 5092.0 5122.9 5127.2 5147.2 4863.6 4902.2 4914.9 4929.1 4959.7 4871.4 4885.5 4885.6 4890.9 4903.4 4347.1 4415.1 4453.4 4456.8 4475.2 5908.3 5978.2 6007.8 6013.8 6073.6 5664.5 5689.9 5695.6 5709.2 5736.5 6549.2 6593.1 6594.9 6628.5 6656.4 4882.2 4885.9 4915.9 4916.0 4949.9 6604.6 6645.5 6758.8 6762.5 6793.9 4915.2 4922.3 4936.6 4966.0 5025.3 4989.5 5020.9 5042.7 5086.4 5132.8 5580.2 5597.2 5646.5 5666.2 5679.2 6528.2 6528.5 6535.4 6576.6 6601.8 1771.3 1773.0 1775.7 1785.9 1797.4 1171.2 1220.7 1223.8 1238.4 1245.0 5728.9 5764.3 5767.8 5822.7 5837.5 6695.7 6719.5 6732.6 6741.8 6791.5 5690.7 5728.7 5742.4 5786.5 5812.2 3565.8 3597.3 3606.1 3608.6 3612.9 6451.9 6490.5 6509.7 6510.2 6574.0 6802.8 6829.6 6836.4 6865.8 6913.0 6440.4 6476.2 6493.3 6509.4 6528.2 6187.4 6537.9 6660.9 6694.9 6714.6 6554.9 6603.4 6617.8 6650.6 6651.2 6368.7 6391.1 6392.6 6470.2 6510.4 5012.4 5021.3 5028.7 5055.6 5077.5 6520.2 6644.0 6712.3 6757.8 6762.0 6296.1 6458.2 6524.6 6554.7 6559.9 6448.5 6476.3 6530.6 6535.3 6547.7 6361.8 6423.3 6443.3 6465.1 6525.4 6539.3 6612.8 6627.2 6651.3 6656.6 6256.2 6339.4 6371.7 6476.5 6483.0 04:55:28 INFO - PID 5769 | 04:55:28 INFO - PID 5769 | [#5] yui.html Cycles:180 Average:22809.84 Median:20359.59 stddev:31096.51 (152.7%) stddev-sans-first:31140.19 04:55:28 INFO - PID 5769 | Values: 891.5 899.4 918.6 926.0 927.0 19161.3 20313.2 20406.0 20415.6 20423.1 21035.3 21940.3 21951.6 22062.8 22201.1 1007.6 1023.2 1031.4 1036.9 1038.1 599.5 616.9 1019.6 1026.3 1041.7 1077.7 1089.9 1093.5 1093.9 1095.4 1070.0 1083.7 1087.0 1087.2 1087.7 787.5 792.6 795.6 798.6 800.2 20119.4 20489.2 20507.8 20552.8 20727.4 20445.0 20796.9 20844.3 20914.4 20953.1 16205.9 16252.0 16465.3 16518.3 16649.0 3648.5 3659.6 3662.7 3666.7 3678.4 123983.0 125282.0 125597.0 127585.4 129946.0 16406.3 16535.3 16809.2 16824.7 16976.2 30473.9 31397.5 31442.5 31616.7 31646.4 8404.4 8575.9 8665.5 8673.1 8673.7 4265.2 4298.1 4353.5 4371.2 4388.3 5296.5 5409.1 5411.3 5411.5 5420.3 1082.8 1110.1 1120.1 1129.0 1129.9 567.2 582.6 589.5 599.0 609.4 10733.7 10838.1 11155.0 11233.6 11400.7 516.4 526.5 551.3 578.2 587.3 4680.9 5460.2 5481.1 5566.2 5697.5 101993.5 102168.0 102375.5 102536.0 104387.0 90497.0 90693.0 90898.0 96103.5 96347.0 80763.0 82107.6 83797.6 85421.0 85836.1 11280.8 11287.8 11457.9 11468.3 11636.4 36134.3 37591.1 38037.0 38605.2 38631.4 63247.1 65035.7 65775.3 68796.3 69248.3 13619.0 14118.9 14265.1 14291.2 14447.4 17970.0 18047.4 18197.9 18401.1 18514.4 15347.2 15428.4 15443.2 15460.0 15600.8 16875.2 16899.1 16947.3 16959.5 17079.9 16799.7 16814.4 16903.9 17306.1 17351.7 10798.8 10926.4 11013.5 11024.0 11371.8 12570.3 12600.7 12884.7 13054.5 13103.5 04:55:28 INFO - PID 5769 | -------- Summary: end -------- 04:55:28 INFO - PID 5769 | 04:55:29 INFO - TEST-INFO | 5769: exit 0 04:55:29 INFO - TEST-OK | dromaeo_css | took 1112936ms 04:55:29 INFO - TEST-START | kraken 04:55:29 INFO - Initialising browser for kraken test... 04:55:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56746/getInfo.html -profile /tmp/tmpU4XtC0/profile 04:55:29 INFO - TEST-INFO | started process 6140 (/builds/slave/test/build/application/firefox/firefox http://localhost:56746/getInfo.html) 04:55:34 INFO - TEST-INFO | 6140: exit 0 04:55:35 INFO - Browser initialized. 04:55:35 INFO - Running cycle 1/1 for kraken test... 04:55:35 INFO - TEST-INFO | started process 6366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU4XtC0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:36 INFO - PID 6366 | 04:55:36 INFO - PID 6366 | (/builds/slave/test/build/application/firefox/firefox:6420): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:55:36 INFO - PID 6366 | 04:55:46 INFO - PID 6366 | RSS: Main: 173854720 04:55:46 INFO - PID 6366 | 04:55:46 INFO - PID 6366 | serialization: Helvetica 04:55:46 INFO - PID 6366 | serialization: Arial 04:55:49 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56746/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:49 INFO - PID 6366 | RSS: Main: 178618368 04:55:49 INFO - PID 6366 | 04:55:50 INFO - PID 6366 | serialization: Helvetica 04:55:50 INFO - PID 6366 | serialization: Arial 04:55:52 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56746/tests/kraken/driver.html?testName=audio-dft) 04:55:53 INFO - PID 6366 | RSS: Main: 179212288 04:55:53 INFO - PID 6366 | 04:55:53 INFO - PID 6366 | serialization: Helvetica 04:55:53 INFO - PID 6366 | serialization: Arial 04:55:56 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56746/tests/kraken/driver.html?testName=audio-fft) 04:55:57 INFO - PID 6366 | RSS: Main: 173998080 04:55:57 INFO - PID 6366 | 04:55:57 INFO - PID 6366 | serialization: Helvetica 04:55:57 INFO - PID 6366 | serialization: Arial 04:55:59 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56746/tests/kraken/driver.html?testName=audio-oscillator) 04:55:59 INFO - PID 6366 | RSS: Main: 174661632 04:55:59 INFO - PID 6366 | 04:55:59 INFO - PID 6366 | serialization: Helvetica 04:55:59 INFO - PID 6366 | serialization: Arial 04:56:02 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:02 INFO - PID 6366 | RSS: Main: 174739456 04:56:02 INFO - PID 6366 | 04:56:02 INFO - PID 6366 | serialization: Helvetica 04:56:02 INFO - PID 6366 | serialization: Arial 04:56:05 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56746/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:06 INFO - PID 6366 | RSS: Main: 177102848 04:56:06 INFO - PID 6366 | 04:56:06 INFO - PID 6366 | serialization: Helvetica 04:56:06 INFO - PID 6366 | serialization: Arial 04:56:10 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56746/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:10 INFO - PID 6366 | RSS: Main: 176910336 04:56:10 INFO - PID 6366 | 04:56:10 INFO - PID 6366 | serialization: Helvetica 04:56:10 INFO - PID 6366 | serialization: Arial 04:56:13 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56746/tests/kraken/driver.html?testName=json-parse-financial) 04:56:14 INFO - PID 6366 | RSS: Main: 177053696 04:56:14 INFO - PID 6366 | 04:56:14 INFO - PID 6366 | serialization: Helvetica 04:56:14 INFO - PID 6366 | serialization: Arial 04:56:15 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:16 INFO - PID 6366 | RSS: Main: 176828416 04:56:16 INFO - PID 6366 | 04:56:16 INFO - PID 6366 | serialization: Helvetica 04:56:16 INFO - PID 6366 | serialization: Arial 04:56:18 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:19 INFO - PID 6366 | RSS: Main: 173830144 04:56:19 INFO - PID 6366 | 04:56:19 INFO - PID 6366 | serialization: Helvetica 04:56:19 INFO - PID 6366 | serialization: Arial 04:56:21 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:22 INFO - PID 6366 | RSS: Main: 174268416 04:56:22 INFO - PID 6366 | 04:56:22 INFO - PID 6366 | serialization: Helvetica 04:56:22 INFO - PID 6366 | serialization: Arial 04:56:24 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:25 INFO - PID 6366 | RSS: Main: 174727168 04:56:25 INFO - PID 6366 | 04:56:25 INFO - PID 6366 | serialization: Helvetica 04:56:25 INFO - PID 6366 | serialization: Arial 04:56:28 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:29 INFO - PID 6366 | RSS: Main: 174456832 04:56:29 INFO - PID 6366 | 04:56:29 INFO - PID 6366 | serialization: Helvetica 04:56:29 INFO - PID 6366 | serialization: Arial 04:56:31 INFO - PID 6366 | Cycle 1(1): loaded http://localhost:56746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56746/tests/kraken/driver.html?testName=ai-astar) 04:56:31 INFO - PID 6366 | RSS: Main: 175939584 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | __start_tp_report 04:56:31 INFO - PID 6366 | _x_x_mozilla_page_load 04:56:31 INFO - PID 6366 | _x_x_mozilla_page_load_details 04:56:31 INFO - PID 6366 | |i|pagename|runs| 04:56:31 INFO - PID 6366 | |0;ai-astar;99;106;101;118;109;116;108;99;109;106 04:56:31 INFO - PID 6366 | |1;audio-beat-detection;148;118;138;163;123;150;155;119;178;126 04:56:31 INFO - PID 6366 | |2;audio-dft;163;163;163;168;162;169;165;173;164;165 04:56:31 INFO - PID 6366 | |3;audio-fft;75;74;75;185;83;76;77;81;150;76 04:56:31 INFO - PID 6366 | |4;audio-oscillator;79;80;133;77;83;79;139;83;78;138 04:56:31 INFO - PID 6366 | |5;imaging-gaussian-blur;119;117;115;114;115;115;114;114;114;115 04:56:31 INFO - PID 6366 | |6;imaging-darkroom;151;151;150;151;154;151;153;153;152;150 04:56:31 INFO - PID 6366 | |7;imaging-desaturate;101;95;98;99;97;94;94;94;94;94 04:56:31 INFO - PID 6366 | |8;json-parse-financial;61;56;57;63;55;57;56;58;55;55 04:56:31 INFO - PID 6366 | |9;json-stringify-tinderbox;59;61;58;58;58;62;58;58;58;58 04:56:31 INFO - PID 6366 | |10;stanford-crypto-aes;82;80;80;87;94;80;77;93;88;87 04:56:31 INFO - PID 6366 | |11;stanford-crypto-ccm;139;133;125;133;130;141;129;120;123;169 04:56:31 INFO - PID 6366 | |12;stanford-crypto-pbkdf2;189;180;180;172;173;172;177;172;190;172 04:56:31 INFO - PID 6366 | |13;stanford-crypto-sha256-iterative;70;68;67;76;68;66;70;66;66;68 04:56:31 INFO - PID 6366 | __end_tp_report 04:56:31 INFO - PID 6366 | __start_cc_report 04:56:31 INFO - PID 6366 | _x_x_mozilla_cycle_collect,959 04:56:31 INFO - PID 6366 | __end_cc_report 04:56:31 INFO - PID 6366 | __startTimestamp1502106991318__endTimestamp 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | ------- Summary: start ------- 04:56:31 INFO - PID 6366 | Number of tests: 14 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#0] ai-astar Cycles:10 Average:107.10 Median:112.50 stddev:6.47 (5.8%) stddev-sans-first:6.16 04:56:31 INFO - PID 6366 | Values: 99.0 106.0 101.0 118.0 109.0 116.0 108.0 99.0 109.0 106.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:149.00 stddev:20.39 (13.7%) stddev-sans-first:21.51 04:56:31 INFO - PID 6366 | Values: 148.0 118.0 138.0 163.0 123.0 150.0 155.0 119.0 178.0 126.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:3.47 (2.1%) stddev-sans-first:3.56 04:56:31 INFO - PID 6366 | Values: 163.0 163.0 163.0 168.0 162.0 169.0 165.0 173.0 164.0 165.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:39.09 (51.4%) stddev-sans-first:40.77 04:56:31 INFO - PID 6366 | Values: 75.0 74.0 75.0 185.0 83.0 76.0 77.0 81.0 150.0 76.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:79.00 stddev:27.55 (34.9%) stddev-sans-first:28.45 04:56:31 INFO - PID 6366 | Values: 79.0 80.0 133.0 77.0 83.0 79.0 139.0 83.0 78.0 138.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.62 (1.4%) stddev-sans-first:0.97 04:56:31 INFO - PID 6366 | Values: 119.0 117.0 115.0 114.0 115.0 115.0 114.0 114.0 114.0 115.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 04:56:31 INFO - PID 6366 | Values: 151.0 151.0 150.0 151.0 154.0 151.0 153.0 153.0 152.0 150.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.50 stddev:2.58 (2.7%) stddev-sans-first:2.01 04:56:31 INFO - PID 6366 | Values: 101.0 95.0 98.0 99.0 97.0 94.0 94.0 94.0 94.0 94.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.71 (4.8%) stddev-sans-first:2.52 04:56:31 INFO - PID 6366 | Values: 61.0 56.0 57.0 63.0 55.0 57.0 56.0 58.0 55.0 55.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.00 stddev:1.48 (2.5%) stddev-sans-first:1.56 04:56:31 INFO - PID 6366 | Values: 59.0 61.0 58.0 58.0 58.0 62.0 58.0 58.0 58.0 58.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:87.00 stddev:5.87 (6.7%) stddev-sans-first:6.13 04:56:31 INFO - PID 6366 | Values: 82.0 80.0 80.0 87.0 94.0 80.0 77.0 93.0 88.0 87.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:133.00 stddev:13.90 (10.5%) stddev-sans-first:14.64 04:56:31 INFO - PID 6366 | Values: 139.0 133.0 125.0 133.0 130.0 141.0 129.0 120.0 123.0 169.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.50 stddev:7.01 (3.9%) stddev-sans-first:6.13 04:56:31 INFO - PID 6366 | Values: 189.0 180.0 180.0 172.0 173.0 172.0 177.0 172.0 190.0 172.0 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:3.03 (4.5%) stddev-sans-first:3.16 04:56:31 INFO - PID 6366 | Values: 70.0 68.0 67.0 76.0 68.0 66.0 70.0 66.0 66.0 68.0 04:56:31 INFO - PID 6366 | -------- Summary: end -------- 04:56:31 INFO - PID 6366 | 04:56:31 INFO - PID 6366 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:56:31 INFO - TEST-INFO | 6366: exit 0 04:56:32 INFO - TEST-OK | kraken | took 62624ms 04:56:32 INFO - SUITE-END | took 1175s 04:56:32 INFO - Completed test suite (00:19:35) 04:56:32 INFO - javascript benchmark 04:56:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8493.018391199319, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.2089477630607, 3181.013885695434, 3199.6320423151315, 3204.3911656785217, 3253.918652033699, 6192.814215573529, 6276.246850377961, 6332.9683351583235, 6344.1752572165615, 6345.270293916201, 6139.140520327158, 6244.750209991595, 6252.499800015999, 6275.497960163188, 6305.968470157654, 5692.146178073281, 5728.369879313273, 5740.138979153139, 5761.107028410603, 5768.39431859655, 5756.165356023374, 5769.624974376673, 5771.653700777946, 5775.3358363788075, 5777.971110144465, 5769.221155144065, 5774.5091667208335, 5792.594518383715, 5793.5365170786445, 5800.506956908668, 5763.596548241625, 5765.682887441189, 5769.07694768835, 5769.076947688392, 5770.422957704238, 5709.0, 5743.856403589902, 5788.507976821933, 5807.041838096709, 5891.322497912752, 6105.511559075263, 6118.204633397674, 6229.3459186785185, 6251.062340648894, 6261.373862613747, 6670.599764014126, 6677.232118306409, 6685.465162786965, 6702.195736511601, 6706.0, 6735.696893639798, 6809.421199198074, 6812.62530560819, 6826.419754320888, 6849.794506164823, 6247.593906396115, 6255.530835187379, 6337.397947195055, 6349.809505714836, 6354.17395738551, 6884.173899132136, 6884.65576721162, 6988.965055174692, 7005.859882802315, 7008.088948436671, 6486.708098135595, 6496.123023391876, 6567.080608714784, 6569.868602627921, 6578.407943285031, 6598.571092878948, 6631.436327912182, 6649.567778094505, 6677.532572719863, 6778.254392016875, 6711.932880671228, 6715.294894036154, 6730.8653826924165, 6753.8649227015185, 6795.796126116125, 6640.568363056386, 6646.069550262967, 6706.530542861953, 6769.356911093439, 6848.3494068063455, 5389.7035663038905, 5438.102713052381, 5466.125419932871, 5537.58468114893, 5553.028220061473, 4680.695754775928, 4712.787924543404, 4752.619790416758, 4763.976180119077, 4771.045790841846, 5797.507211887037, 5815.185873977646, 5876.206712093898, 5892.646441213541, 5904.586678932519, 6725.562838415487, 6736.629485378253, 6803.421709154777, 6818.454523638097, 6835.213950395669, 5735.541156707453, 5791.594588378773, 5798.59409841307, 5842.59101862874, 5869.941300586939, 5975.492083172892, 6001.5798894077, 6008.399160084044, 6010.819675409657, 6030.849228769228, 6401.1678481798, 6501.382368675063, 6580.539362244693, 6597.274299827015, 6602.1747281589805, 6684.364985326386, 6709.597424154371, 6737.3599508046655, 6781.593104413751, 6802.0, 6459.063435801689, 6480.740770369132, 6576.539642224999, 6601.801945941629, 6611.438027767694, 6517.989711594711, 6579.4736421085245, 6583.111279977142, 6586.341365863375, 6619.3049729779605, 6715.093462382516, 6716.462682985447, 6733.966330168318, 6803.013563033233, 6817.965910170616, 6526.608403495616, 6589.209294884645, 6590.967045164935, 6598.274189839018, 6598.472122230114, 6466.741330346922, 6501.674916254263, 6514.348565143448, 6586.967065164644, 6589.209294884645, 6326.588771729823, 6432.260290066515, 6451.870962580816, 6486.05952136947, 6537.1174891389055, 6493.4155925965, 6529.4776417885505, 6582.80251592453, 6591.538592298493, 6592.406683398517, 6316.905246421399, 6383.457406120346, 6384.93615063862, 6397.6481293529305, 6399.840003999937], "value": 6145.150025327923, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.9636866341018, 856.503228127686, 882.8763973043775, 885.0618344554772, 1150.131650603794, 30965.69034309656, 31503.0, 42821.785891070576, 43530.0, 43634.34548481775, 43822.34266486005, 44298.33552496715, 44305.556944430544, 44436.0, 44472.77763611177, 7354.0, 7754.302112809846, 7864.056313242419, 7964.5619490927975, 7983.401244906655, 7752.806179845521, 7846.176151504095, 7884.053913530356, 7886.566238856861, 7888.842223155533, 7881.330086942617, 7905.644246008944, 7912.248336408032, 7927.40544459165, 7947.960260198691, 7747.2640099190485, 7776.222377762207, 7811.648475818602, 7820.921790782077, 7846.215378462165, 7737.8452430951065, 7803.0, 7819.765407037741, 7832.804179895491, 7838.37293016563, 40247.7987610063, 40541.39187912184, 40596.79701601503, 40639.18721625551, 40718.38922416166, 3573.731970102253, 3598.1364472526407, 3612.5123108380294, 3640.071781695677, 3651.835667394974, 31834.0, 31862.0, 31990.360192796015, 32021.679783202104, 32044.0, 4887.291342755316, 5034.924476132861, 5074.3657042869645, 5079.3650793650795, 5089.41471730752, 185782.0, 186004.0, 186485.0, 187015.0, 187294.0, 49782.50217497851, 49807.750961244965, 49810.50189498131, 49846.75076624594, 49921.75039124781, 51417.0, 51418.0, 51461.74269128705, 51481.742591286806, 51559.0, 16065.919670401574, 16294.755578666329, 16382.098984555725, 16389.590260243353, 16402.753958690628, 11118.332900026024, 11379.089672826154, 13355.332233388486, 13420.597382078553, 13549.25479098659, 14475.0, 14527.636809079646, 14561.854381456262, 14673.119612823264, 14717.19055451939, 5816.796412125555, 5898.734556944948, 5944.464998150101, 5948.078047902582, 5950.583459157818, 997.4464172384396, 1024.329064462778, 1027.9331843430152, 1028.7890982348601, 1035.668586052456, 22934.541309173725, 23049.847507624552, 23123.76876231216, 23130.0, 23246.76753232446, 1085.7014321061772, 1105.9778804424027, 1113.3153110836777, 1117.4412793603199, 1130.5421304371744, 12216.26702397859, 12363.258204507758, 12440.81812227837, 12493.625191244277, 12582.18215815969, 235239.0, 239012.0, 239048.0, 239077.0, 239587.0, 54508.18237726437, 54757.0, 54911.17633235505, 55330.446695533334, 55330.72334638381, 1475.5942115917994, 1480.0897448069575, 1516.0221657031373, 1518.4229992602961, 1524.7560390337492, 22310.442238944157, 22483.775162248166, 22752.20367287137, 22856.200032998764, 23172.073117075128, 39305.0, 39453.01367465837, 39471.802640986614, 39476.605233947295, 39508.2098358037, 199806.0, 199874.0, 199951.0, 200210.0, 200773.0, 34833.47749783705, 35408.29183416369, 38788.0, 39674.2065158701, 39696.0, 48884.51115488942, 49134.0, 49354.25968610402, 49482.50517494923, 49653.0, 34909.0, 35275.82362088173, 35328.823355883054, 35564.288714225055, 35734.0, 34475.31049378948, 34944.0, 35230.97201973153, 35355.0, 35821.0, 38521.36981668752, 38690.613093869826, 38803.02992425212, 38986.2202755949, 39019.41470877882, 33371.666283336854, 33637.66362336443, 33706.15734606556, 33720.49419258664, 33811.0, 24737.50524989526, 25141.49717005613, 25346.619800703374, 25828.741712582632, 25845.353866153495], "value": 17679.234270196914, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5608293779666, 588.629163626915, 590.8168467774992, 598.7694737526052, 603.2851071480295, 22789.772102278974, 22818.771812281873, 23655.763442365573, 23843.880780596093, 23926.04295828167, 26280.605790913105, 27067.729322706768, 27102.5934610981, 27106.864465677645, 27131.45737085257, 6625.602463852172, 6728.0, 6733.259341472434, 6760.898586521206, 6796.592204467748, 6206.441420272175, 6482.578632388903, 6508.511861610375, 6569.901451478232, 6676.666166691671, 6440.0, 6456.774012909549, 6467.029945508164, 6493.480521558264, 6507.056476810883, 6403.96798016007, 6455.5158363122955, 6465.739180859734, 6472.90290645643, 6479.708413121421, 6019.856227316795, 6020.6688632125215, 6026.668533230671, 6050.152978583002, 6050.27396712393, 29075.273118172005, 29751.107466776033, 30390.0, 30775.0, 30784.846075769477, 1933.0528041259822, 1943.5529828139465, 1954.6090781843545, 1961.225316000172, 1967.3507742444958, 19199.520011999673, 19412.320568780025, 20249.190032398685, 20272.189112435484, 20332.5933481331, 2495.3262619092925, 2507.109975958545, 2533.518631460017, 2540.5554028045017, 2546.752091475182, 143690.0, 145325.27337363246, 147739.0, 149187.0, 156461.21769391195, 14989.250537473083, 15052.54842354731, 15078.596736364134, 15151.696966060617, 15588.129424468909, 24069.638955415332, 24155.75844241535, 24176.274711758677, 24185.15351962673, 24261.51476970486, 9708.368956017835, 9936.701898943043, 9940.403575785476, 10141.442220677785, 10649.414282214397, 8914.0, 8925.73222803317, 8931.73204803857, 9044.186023257938, 9049.276057915351, 7816.7264145754625, 9467.621295148117, 9656.27577931658, 9691.07934746198, 9813.754656133653, 2877.956830647542, 2912.257374369565, 2934.163763327484, 2942.4556457055087, 2976.4493568689427, 940.4404329612521, 968.8740463739668, 976.3897564022486, 978.8874279457954, 983.2822039910905, 19720.0, 19979.400617981482, 20228.898855505628, 20293.797062029487, 20457.38627841167, 1030.845373194027, 1032.8192566300868, 1046.5552140340326, 1052.5053224984244, 1056.6090546497692, 11009.339439633648, 11133.220674552866, 11156.442177891073, 11166.497507612177, 11192.664220073411, 441348.0, 458391.0, 482570.0, 487068.0, 487818.0, 117330.41334793271, 118952.40523797326, 121102.0, 121765.0, 122960.0, 1235.5552001279532, 1252.5553428532921, 1300.057458342694, 1303.7262174943369, 1304.3217526886156, 20834.58330833405, 20965.161393544087, 21075.26236581712, 21398.53916799588, 21531.354059378245, 54183.0, 54333.0, 55746.16380754211, 56031.43968560262, 57537.42462575321, 69896.65051674913, 70164.0, 70188.29811701817, 70238.64880675563, 71161.0, 14806.62983425423, 14938.253087345372, 14989.325480353193, 14992.925035374754, 15001.624959376102, 21590.892045539673, 22055.889720551295, 23638.64542031905, 23847.761522384553, 23907.641385379582, 18078.638427231646, 18447.631047379247, 18660.2535898568, 18802.34191803335, 18816.341428049953, 16934.915325423786, 17099.48701538906, 17103.401380951607, 17261.309547618457, 17524.73712894282, 18254.817451825842, 19120.80879191246, 19266.903665481583, 19313.90343048276, 19609.0, 14792.704145917236, 14849.257537123316, 14993.550193494213, 14995.2502374883, 15020.92489537589, 17732.91133544324, 18818.059097045367, 18967.620647587246, 19073.237070517025, 19236.0], "value": 12206.770680939058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.7822359310712, 1351.9526816561422, 1355.4307190979787, 1363.059488952622, 1384.1625816381086, 11966.700832479171, 13689.452421903125, 14244.0, 14279.2860356982, 14283.78574321386, 11778.411079446016, 13424.463021479154, 13776.724465510684, 13844.792328115087, 13848.0, 2663.6404085448507, 2742.1362270884606, 2743.7667798237176, 2747.175847245818, 2748.8625568721486, 2636.894524219029, 2684.127658510982, 2696.8651567421552, 2701.783857291412, 2708.444768822387, 2671.9732802672015, 2718.415540658758, 2722.2105589379057, 2722.8774705138217, 2722.9591556126675, 2577.072253988563, 2583.638290639303, 2597.052075992259, 2601.7398260174023, 2603.5313643544155, 2508.5108403861254, 2539.6444497770326, 2542.834715743489, 2555.859427731474, 2557.2583950654475, 13429.39567719455, 13650.658733531642, 13668.0, 13691.315434228249, 13708.725825483434, 7613.961930190369, 7957.124716281204, 7958.562279074648, 7973.162817904153, 7977.16239794819, 4938.3580134582635, 5090.490950904917, 5152.201408781645, 5301.1783173608155, 5311.893762124736, 1762.5064981804987, 1764.9647007059787, 1803.2696757813108, 1820.1445320699384, 1839.448165550343, 22903.19838805634, 22907.0, 22981.54036919269, 22983.88508057466, 23024.0, 6624.171978502687, 6937.271586483447, 7026.859462810715, 7113.110861142357, 7180.425565954711, 18490.260389584266, 18538.25846966106, 18564.164612592467, 18605.441836744918, 18610.348637797884, 7800.92199078002, 7941.285284324438, 7979.441439099207, 8282.544460054754, 8314.958425207835, 7141.357277844915, 7318.926810731931, 7360.926390736024, 7390.224026477143, 7399.0, 5006.148954677714, 5130.384353877558, 5147.613928955343, 5167.044096842021, 5190.11767999441, 1503.158231390403, 1545.1424459424902, 1552.767084937246, 1558.789563408948, 1575.487966410921, 888.3426264564176, 913.2511340700562, 915.8031023330016, 921.8478950973148, 926.3885835348638, 7402.444816638774, 7438.4049276057785, 7440.181580026193, 7470.663820128108, 7604.771856844303, 721.0806222066907, 723.2622724820653, 727.7052793618593, 730.6456368661195, 735.3161559749377, 4888.755562221874, 5199.688018718889, 5243.947560524422, 5270.0, 5361.946380536223, 19250.80749192518, 19496.31762888292, 19739.605207895762, 19744.60510789805, 19937.202511899653, 18937.0, 19449.22203111888, 19501.804981949997, 19678.508037299183, 19920.203191872453, 10773.838392423962, 10782.137429005661, 10863.076638485818, 10886.510107045202, 10895.509702063426, 7791.532508049535, 7916.643751031333, 8502.659893604186, 8771.824563508822, 8902.332325075517, 16517.752233716263, 16563.0, 17023.23395447183, 17112.657746844743, 17552.648947020734, 17588.29646814164, 17665.646687065928, 17699.82300177033, 17707.46877593674, 17807.91096044563, 11300.49147788335, 11357.829632555353, 11623.12826537996, 11660.30038197711, 11664.475098620413, 13053.738925221633, 13062.673433164247, 13069.803952940523, 13108.475660973454, 13118.672033199246, 10462.895371046192, 10464.424456654957, 10931.180161488079, 11079.279846809932, 11133.220674552704, 9839.85240221383, 10024.097831195228, 10251.48742562854, 10282.228832837418, 10400.115990140923, 8571.100034496289, 8616.741497755078, 8675.262602678842, 8685.392022558613, 8688.304935605263, 7095.538789978635, 7187.209406965334, 7244.492885497964, 7324.121105467378, 7427.925720742724, 7227.27727227273, 7242.52923559988, 7363.852722945404, 7375.668094935848, 7437.776866694008], "value": 6376.963828608366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.43090568454016, 508.6464906889711, 521.3587287636208, 533.0012453300125, 533.8905524367505, 6271.341509141537, 6319.431251187387, 6325.683715814214, 6346.587471814329, 6350.0, 6206.937930620692, 6242.375762423755, 6259.499240060795, 6273.278572964111, 6303.55875088744, 5127.948720512803, 5172.120739474289, 5196.350456192976, 5206.7656955436905, 5225.8954820903555, 4812.157872372339, 5092.0, 5122.871928201806, 5127.230915362707, 5147.202183661539, 4863.562279394854, 4902.166631672624, 4914.877128071809, 4929.126931765942, 4959.677620954644, 4871.4397844248015, 4885.5114488551035, 4885.584725298354, 4890.853274401774, 4903.387076615423, 4347.087111706545, 4415.050764085705, 4453.376527286183, 4456.799444025027, 4475.239209334421, 5908.320543137551, 5978.192943952554, 6007.789727359522, 6013.789517366915, 6073.635581865102, 5664.518515926151, 5689.9146512802345, 5695.572832037572, 5709.200711900337, 5736.512396446307, 6549.214094308666, 6593.076969224312, 6594.911839546517, 6628.4697224221945, 6656.434203092695, 4882.194437917739, 4885.902281954376, 4915.926261106087, 4915.950840491585, 4949.851504454872, 6604.636744979072, 6645.501587380917, 6758.8310292242595, 6762.492813038993, 6793.864122717568, 4915.16442204826, 4922.310876477296, 4936.605071594336, 4965.977558177888, 5025.271335656383, 4989.501049895054, 5020.924686129711, 5042.697438153649, 5086.440491546001, 5132.8460146195675, 5580.246666700024, 5597.216389705363, 5646.520045796071, 5666.178404131378, 5679.204911312419, 6528.2166140062545, 6528.477721782246, 6535.44448721864, 6576.605403675795, 6601.788400885757, 1771.2737777511159, 1772.9556761081076, 1775.7336399539913, 1785.8839175453554, 1797.3709201779272, 1171.221137943258, 1220.664317312746, 1223.7552489501957, 1238.4365113873166, 1244.9626511204679, 5728.914066289009, 5764.279465066867, 5767.798127065616, 5822.700033486749, 5837.532997360201, 6695.732170713117, 6719.529632925746, 6732.629705366154, 6741.764038258735, 6791.524593278423, 5690.7439165237665, 5728.656280623176, 5742.425757424224, 5786.537077033911, 5812.157237200582, 3565.8038807865814, 3597.2625611749527, 3606.1165014571598, 3608.5850127235703, 3612.8735494257576, 6451.870962580722, 6490.545661803629, 6509.707063182168, 6510.153680021567, 6574.022716256596, 6802.8299292517095, 6829.556078854858, 6836.350546698056, 6865.794026179223, 6912.965435172892, 6440.420362167428, 6476.158099447041, 6493.31820158886, 6509.381608747256, 6528.249251336157, 6187.412195841388, 6537.934620653923, 6660.900086498609, 6694.933050669431, 6714.597124172566, 6554.868902622016, 6603.405693487609, 6617.834554135992, 6650.600963942179, 6651.235107962646, 6368.713407896563, 6391.10524526576, 6392.561673623398, 6470.158879345843, 6510.44661203803, 5012.423571289349, 5021.342956824166, 5028.6674031382445, 5055.595552355876, 5077.543021128116, 6520.217573891164, 6643.966780166068, 6712.295209002984, 6757.797266082025, 6762.039008687426, 6296.118543403835, 6458.22501299847, 6524.641144737085, 6554.705038273384, 6559.901601476077, 6448.451881590117, 6476.255230648348, 6530.640814755234, 6535.3137920517665, 6547.70535325902, 6361.840953976188, 6423.261324947691, 6443.329869714621, 6465.127207826883, 6525.3800888915475, 6539.280679125388, 6612.768553100618, 6627.204735431586, 6651.268360480247, 6656.633885136364, 6256.217972753406, 6339.366063393808, 6371.745130194926, 6476.514261430318, 6483.0], "value": 5054.478495028541, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.5319457284928, 899.4018977380042, 918.5774543709894, 926.0, 927.0497739816687, 19161.329353472633, 20313.18747250112, 20406.0, 20415.591688166227, 20423.080961356736, 21035.263765768203, 21940.341789746333, 21951.560968780614, 22062.779372206274, 22201.11195552176, 1007.6322142418002, 1023.2376879224988, 1031.437866362834, 1036.9429681367521, 1038.112413886124, 599.4814485470059, 616.9167162433059, 1019.6176433837311, 1026.2508368890676, 1041.7499800047972, 1077.665923563694, 1089.9073578745815, 1093.5079214353532, 1093.928894621851, 1095.3865835132312, 1070.0476575847501, 1083.7236504691293, 1087.0271107358908, 1087.1846115413439, 1087.690008347625, 787.5392895156341, 792.6393490961599, 795.6021989005498, 798.62863768348, 800.2357748350312, 20119.39641810748, 20489.180432782672, 20507.794922050885, 20552.794472055237, 20727.378178654664, 20445.0, 20796.856172910484, 20844.27045053431, 20914.37256882296, 20953.05711242998, 16205.91897040519, 16252.024878507327, 16465.25906334218, 16518.2566784495, 16649.0, 3648.452732090181, 3659.5974442811535, 3662.688671462929, 3666.6699997000132, 3678.411454167347, 123983.0, 125282.0, 125597.0, 127585.36207318904, 129946.0, 16406.261718222708, 16535.338586456648, 16809.159542023095, 16824.74762878558, 16976.236069376908, 30473.933412330905, 31397.52903706446, 31442.528362074587, 31616.683833161835, 31646.367072658417, 8404.369672274604, 8575.914240857637, 8665.523396213142, 8673.089325620846, 8673.696420625374, 4265.210935976854, 4298.118885628502, 4353.477582690098, 4371.235033869124, 4388.341748737651, 5296.523312901857, 5409.080456322435, 5411.269478620415, 5411.540019098421, 5420.349558053059, 1082.767205050902, 1110.123002827757, 1120.1430905357408, 1129.0290350298737, 1129.88701129888, 567.1804242869097, 582.6300299309969, 589.5136512377306, 598.9730462129214, 609.3723464831231, 10733.731656708489, 10838.078763305208, 11155.0, 11233.606823761129, 11400.657980260605, 516.4267662894184, 526.4866754914004, 551.310861423221, 578.2251782611321, 587.3275100010464, 4680.859574212779, 5460.235567020621, 5481.123020316731, 5566.248556444909, 5697.4587414195585, 101993.49003254937, 102168.0, 102375.4881225589, 102536.0, 104387.0, 90497.0, 90693.0, 90898.0, 96103.51948240215, 96347.0, 80763.0, 82107.5894620523, 83797.58101209455, 85421.0, 85836.14163858406, 11280.7743845121, 11287.7742445149, 11457.885421145682, 11468.254563453349, 11636.36000020007, 36134.27731445304, 37591.060223494635, 38037.0, 38605.22789544137, 38631.42052869153, 63247.05129423155, 65035.67482162559, 65775.34224657693, 68796.312036879, 69248.3075169262, 13619.0, 14118.858811411754, 14265.144091354552, 14291.213983231022, 14447.422103115758, 17970.0, 18047.368342107962, 18197.909010454863, 18401.079946002916, 18514.44456666302, 15347.155906425254, 15428.382864685287, 15443.150626715638, 15460.0, 15600.84399155994, 16875.156242188088, 16899.070551119315, 16947.32210711558, 16959.491215263562, 17079.914600426917, 16799.74800377971, 16814.411495597597, 16903.915480422518, 17306.13469326554, 17351.7397239039, 10798.838017429587, 10926.399048052115, 11013.504392302526, 11024.0, 11371.772564548828, 12570.308633025272, 12600.74798504043, 12884.742305154032, 13054.477820887438, 13103.475860965455], "value": 8779.259017616618, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 101.0, 118.0, 109.0, 116.0, 108.0, 99.0, 109.0, 106.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 138.0, 163.0, 123.0, 150.0, 155.0, 119.0, 178.0, 126.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 168.0, 162.0, 169.0, 165.0, 173.0, 164.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 185.0, 83.0, 76.0, 77.0, 81.0, 150.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 133.0, 77.0, 83.0, 79.0, 139.0, 83.0, 78.0, 138.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 154.0, 151.0, 153.0, 153.0, 152.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 98.0, 99.0, 97.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 57.0, 63.0, 55.0, 57.0, 56.0, 58.0, 55.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 58.0, 58.0, 58.0, 62.0, 58.0, 58.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 87.0, 94.0, 80.0, 77.0, 93.0, 88.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 125.0, 133.0, 130.0, 141.0, 129.0, 120.0, 123.0, 169.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 180.0, 180.0, 172.0, 173.0, 172.0, 177.0, 172.0, 190.0, 172.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 76.0, 68.0, 66.0, 70.0, 66.0, 66.0, 68.0], "value": 68.5, "unit": "score"}]}]} 04:56:32 INFO - Return code: 0 04:56:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:32 INFO - # TBPL SUCCESS # 04:56:32 INFO - Running post-action listener: _package_coverage_data 04:56:32 INFO - Running post-action listener: _resource_record_post_action 04:56:32 INFO - [mozharness: 2017-08-07 11:56:32.597108Z] Finished run-tests step (success) 04:56:32 INFO - Running post-run listener: _resource_record_post_run 04:56:32 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 618496; Write bytes: 431661056; Read time: 120; Write time: 439120 04:56:32 INFO - TinderboxPrint: CPU usage
13.2% 04:56:32 INFO - TinderboxPrint: I/O read bytes / time
618,496 / 120 04:56:32 INFO - TinderboxPrint: I/O write bytes / time
431,661,056 / 439,120 04:56:32 INFO - TinderboxPrint: CPU idle
8,265.0 (86.8%) 04:56:32 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 04:56:32 INFO - TinderboxPrint: Swap in / out
0 / 0 04:56:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107433984; Read time: 0; Write time: 138768 04:56:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:56:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 614400; Write bytes: 323829760; Read time: 104; Write time: 300324 04:56:33 INFO - Running post-run listener: _upload_blobber_files 04:56:33 INFO - Blob upload gear active. 04:56:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:33 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 04:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:56:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:34 INFO - (blobuploader) - INFO - Done attempting. 04:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:41 INFO - (blobuploader) - INFO - Done attempting. 04:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:42 INFO - (blobuploader) - INFO - Done attempting. 04:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:43 INFO - (blobuploader) - INFO - Done attempting. 04:56:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:43 INFO - Return code: 0 04:56:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24d7296b933847f551de1631af93703ec3cd009d8b023cbf14113b04d3238a978ad83fcb75345255df024dec1cee01a19be81fffcfd735f3bc6ecf1cac1679f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1373275b492d9b10788744201a5e883c9eb8164d61e36af6a3fa0d35c037459bc3b45668e06a623e56f0e31bca51e0eb0ae086ae94202eb4721e827014ee8c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d5efef0de9ba5c904f627209a8b991d9caaa8a54b1383635d1ba71c3137af3d07d5301f8b6fa4f965f0a1ebd020fbe7a770359929223e8f5a57c0e2d0219b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c03ed12e4affcc5c5e48fa0391d74f65f965ead68ab729de07a3f5d33a2e86bf091d62483cc939307ee0c8f405fb4de631f490353248d2b37f94638ec6e231d"} 04:56:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:43 INFO - Contents: 04:56:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24d7296b933847f551de1631af93703ec3cd009d8b023cbf14113b04d3238a978ad83fcb75345255df024dec1cee01a19be81fffcfd735f3bc6ecf1cac1679f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1373275b492d9b10788744201a5e883c9eb8164d61e36af6a3fa0d35c037459bc3b45668e06a623e56f0e31bca51e0eb0ae086ae94202eb4721e827014ee8c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d5efef0de9ba5c904f627209a8b991d9caaa8a54b1383635d1ba71c3137af3d07d5301f8b6fa4f965f0a1ebd020fbe7a770359929223e8f5a57c0e2d0219b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c03ed12e4affcc5c5e48fa0391d74f65f965ead68ab729de07a3f5d33a2e86bf091d62483cc939307ee0c8f405fb4de631f490353248d2b37f94638ec6e231d"} 04:56:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:43 INFO - Copying logs to upload dir... 04:56:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.702350 ========= master_lag: -0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-08-07 04:56:43.431029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 04:56:43.435278) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24d7296b933847f551de1631af93703ec3cd009d8b023cbf14113b04d3238a978ad83fcb75345255df024dec1cee01a19be81fffcfd735f3bc6ecf1cac1679f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1373275b492d9b10788744201a5e883c9eb8164d61e36af6a3fa0d35c037459bc3b45668e06a623e56f0e31bca51e0eb0ae086ae94202eb4721e827014ee8c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d5efef0de9ba5c904f627209a8b991d9caaa8a54b1383635d1ba71c3137af3d07d5301f8b6fa4f965f0a1ebd020fbe7a770359929223e8f5a57c0e2d0219b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c03ed12e4affcc5c5e48fa0391d74f65f965ead68ab729de07a3f5d33a2e86bf091d62483cc939307ee0c8f405fb4de631f490353248d2b37f94638ec6e231d"} build_url:https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a24d7296b933847f551de1631af93703ec3cd009d8b023cbf14113b04d3238a978ad83fcb75345255df024dec1cee01a19be81fffcfd735f3bc6ecf1cac1679f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1373275b492d9b10788744201a5e883c9eb8164d61e36af6a3fa0d35c037459bc3b45668e06a623e56f0e31bca51e0eb0ae086ae94202eb4721e827014ee8c5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d5efef0de9ba5c904f627209a8b991d9caaa8a54b1383635d1ba71c3137af3d07d5301f8b6fa4f965f0a1ebd020fbe7a770359929223e8f5a57c0e2d0219b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c03ed12e4affcc5c5e48fa0391d74f65f965ead68ab729de07a3f5d33a2e86bf091d62483cc939307ee0c8f405fb4de631f490353248d2b37f94638ec6e231d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 04:56:43.459597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:56:43.462901) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502105721.757180-1598346184 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:56:43.545966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 04:56:43.546482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 04:56:43.547016) ========= ========= Total master_lag: -0.22 =========