builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1502105771.68 results: success (0) revision: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:11.680116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:11.680561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:11.680832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:11.696846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:11.697104) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 04:36:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-08-07 04:36:13 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.524415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:12.234871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:12.235180) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020884 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:12.284702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-07 04:36:12.285036) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 04:36:13,420 truncating revision to first 12 chars 2017-08-07 04:36:13,420 Setting DEBUG logging. 2017-08-07 04:36:13,420 attempt 1/10 2017-08-07 04:36:13,420 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:36:14,612 unpacking tar archive at: mozilla-central-347ea0d06092/testing/mozharness/ program finished with exit code 0 elapsedTime=1.499080 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-07 04:36:14.065534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:14.065845) ========= script_repo_revision: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:14.066233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:14.066536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 04:36:14.076837) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-08-07 04:36:14.077114) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:15 INFO - MultiFileLogger online at 20170807 04:36:15 in /builds/slave/test 04:36:15 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:36:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:15 INFO - {'append_to_log': False, 04:36:15 INFO - 'base_work_dir': '/builds/slave/test', 04:36:15 INFO - 'blob_upload_branch': 'Firefox', 04:36:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:15 INFO - 'branch': 'Firefox', 04:36:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:15 INFO - 'code_coverage': False, 04:36:15 INFO - 'config_files': ('talos/linux_config.py',), 04:36:15 INFO - 'default_actions': ('clobber', 04:36:15 INFO - 'read-buildbot-config', 04:36:15 INFO - 'download-and-extract', 04:36:15 INFO - 'populate-webroot', 04:36:15 INFO - 'create-virtualenv', 04:36:15 INFO - 'install', 04:36:15 INFO - 'setup-mitmproxy', 04:36:15 INFO - 'run-tests'), 04:36:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:15 INFO - 'disable_ccov_upload': False, 04:36:15 INFO - 'download_minidump_stackwalk': True, 04:36:15 INFO - 'download_symbols': 'ondemand', 04:36:15 INFO - 'enable_stylo': False, 04:36:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:15 INFO - 'gecko_profile': False, 04:36:15 INFO - 'gecko_profile_interval': 0, 04:36:15 INFO - 'installer_path': 'installer.exe', 04:36:15 INFO - 'log_level': 'info', 04:36:15 INFO - 'log_name': 'talos', 04:36:15 INFO - 'log_to_console': True, 04:36:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:15 INFO - 'opt_config_files': (), 04:36:15 INFO - 'pip_index': False, 04:36:15 INFO - 'suite': 'dromaeojs-e10s', 04:36:15 INFO - 'system_bits': '32', 04:36:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:15 INFO - 'title': 'talos-linux64-ix-061', 04:36:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:15 INFO - 'use_talos_json': True, 04:36:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:15 INFO - 'work_dir': 'build'} 04:36:15 INFO - [mozharness: 2017-08-07 11:36:15.322804Z] Running clobber step. 04:36:15 INFO - Running pre-action listener: _resource_record_pre_action 04:36:15 INFO - Running main action method: clobber 04:36:15 INFO - rmtree: /builds/slave/test/build 04:36:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:16 INFO - Running post-action listener: _resource_record_post_action 04:36:16 INFO - [mozharness: 2017-08-07 11:36:16.362548Z] Finished clobber step (success) 04:36:16 INFO - [mozharness: 2017-08-07 11:36:16.362652Z] Running read-buildbot-config step. 04:36:16 INFO - Running pre-action listener: _resource_record_pre_action 04:36:16 INFO - Running main action method: read_buildbot_config 04:36:16 INFO - Using buildbot properties: 04:36:16 INFO - { 04:36:16 INFO - "project": "", 04:36:16 INFO - "product": "firefox", 04:36:16 INFO - "who": "cbook@mozilla.com", 04:36:16 INFO - "installer_path": "public/build/target.tar.bz2", 04:36:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:36:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:36:16 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:36:16 INFO - "stage_platform": "linux64-stylo", 04:36:16 INFO - "basedir": "/builds/slave/test", 04:36:16 INFO - "buildnumber": 261, 04:36:16 INFO - "platform": "ubuntu64_hw_stylo", 04:36:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:36:16 INFO - "slavebuilddir": "test", 04:36:16 INFO - "taskId": "A9tgN9nvShazjdy1h4uByw", 04:36:16 INFO - "branch": "mozilla-central", 04:36:16 INFO - "script_repo_revision": "production", 04:36:16 INFO - "revision": "347ea0d06092d7fcd6c34e2c7ade389b0b71ae31", 04:36:16 INFO - "slavename": "talos-linux64-ix-061", 04:36:16 INFO - "repo_path": "mozilla-central" 04:36:16 INFO - } 04:36:16 INFO - Finding installer, test and symbols from parent task. 04:36:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A9tgN9nvShazjdy1h4uByw'}, attempt #1 04:36:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A9tgN9nvShazjdy1h4uByw'}, attempt #1 04:36:17 INFO - Task dependencies: S8ufqNiHTaGHbnSuZ_Q5fA 04:36:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA'}, attempt #1 04:36:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.test_packages.json 04:36:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.crashreporter-symbols.zip 04:36:18 INFO - Running post-action listener: _resource_record_post_action 04:36:18 INFO - [mozharness: 2017-08-07 11:36:18.278717Z] Finished read-buildbot-config step (success) 04:36:18 INFO - [mozharness: 2017-08-07 11:36:18.278813Z] Running download-and-extract step. 04:36:18 INFO - Running pre-action listener: _resource_record_pre_action 04:36:18 INFO - Running main action method: download_and_extract 04:36:18 INFO - mkdir: /builds/slave/test/build/tests 04:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:18 INFO - trying https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.test_packages.json 04:36:18 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:36:18 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:36:19 INFO - Downloaded 989 bytes. 04:36:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:36:19 INFO - Using the following test package requirements: 04:36:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:36:19 INFO - u'common': [u'target.common.tests.zip'], 04:36:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:36:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:36:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:36:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:36:19 INFO - u'mozbase': [u'target.common.tests.zip'], 04:36:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:36:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:36:19 INFO - u'web-platform': [u'target.common.tests.zip', 04:36:19 INFO - u'target.web-platform.tests.tar.gz'], 04:36:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:36:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:36:19 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:36:19 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:36:19 INFO - Fetch https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip into memory 04:36:31 INFO - Content-Length response header: 54284817 04:36:31 INFO - Bytes received: 54284817 04:36:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:36:42 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:36:42 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:36:42 INFO - Fetch https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.common.tests.zip into memory 04:36:43 INFO - Content-Length response header: 54284817 04:36:43 INFO - Bytes received: 54284817 04:36:56 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:56 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:56 INFO - Fetch https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.talos.tests.zip into memory 04:36:56 INFO - Content-Length response header: 14496008 04:36:56 INFO - Bytes received: 14496008 04:36:57 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:57 INFO - trying https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:57 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:57 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:58 INFO - Downloaded 61730205 bytes. 04:36:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:58 INFO - mkdir: /builds/slave/test/properties 04:36:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:58 INFO - Contents: 04:36:58 INFO - build_url:https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 04:36:58 INFO - Running post-action listener: _resource_record_post_action 04:36:58 INFO - Running post-action listener: set_extra_try_arguments 04:36:58 INFO - [mozharness: 2017-08-07 11:36:58.346597Z] Finished download-and-extract step (success) 04:36:58 INFO - [mozharness: 2017-08-07 11:36:58.346696Z] Running populate-webroot step. 04:36:58 INFO - Running pre-action listener: _resource_record_pre_action 04:36:58 INFO - Running main action method: populate_webroot 04:36:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:58 INFO - 'tests': ['damp', 'tps']}, 04:36:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:36:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:36:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:36:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:58 INFO - 'ts_paint', 04:36:58 INFO - 'tpaint', 04:36:58 INFO - 'sessionrestore', 04:36:58 INFO - 'sessionrestore_many_windows', 04:36:58 INFO - 'sessionrestore_no_auto_restore', 04:36:58 INFO - 'tabpaint']}, 04:36:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:36:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:36:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:58 INFO - 'tsvgr_opacity', 04:36:58 INFO - 'tart', 04:36:58 INFO - 'tscrollx', 04:36:58 INFO - 'tsvg_static']}, 04:36:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:36:58 INFO - 'talos_options': ['--mitmproxy', 04:36:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:36:58 INFO - '--firstNonBlankPaint'], 04:36:58 INFO - 'tests': ['tp6_google', 04:36:58 INFO - 'tp6_youtube', 04:36:58 INFO - 'tp6_amazon', 04:36:58 INFO - 'tp6_facebook']}, 04:36:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:36:58 INFO - 'talos_options': ['--stylo', 04:36:58 INFO - '--mitmproxy', 04:36:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:36:58 INFO - '--firstNonBlankPaint'], 04:36:58 INFO - 'tests': ['tp6_google', 04:36:58 INFO - 'tp6_youtube', 04:36:58 INFO - 'tp6_amazon', 04:36:58 INFO - 'tp6_facebook']}, 04:36:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:36:58 INFO - 'talos_options': ['--stylo', 04:36:58 INFO - '--stylo-threads=1', 04:36:58 INFO - '--mitmproxy', 04:36:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:36:58 INFO - '--firstNonBlankPaint'], 04:36:58 INFO - 'tests': ['tp6_google', 04:36:58 INFO - 'tp6_youtube', 04:36:58 INFO - 'tp6_amazon', 04:36:58 INFO - 'tp6_facebook']}, 04:36:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:58 INFO - 'talos_options': ['--xperf_path', 04:36:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:58 INFO - 'tests': ['tp5n']}}} 04:36:58 INFO - Running post-action listener: _resource_record_post_action 04:36:58 INFO - [mozharness: 2017-08-07 11:36:58.355166Z] Finished populate-webroot step (success) 04:36:58 INFO - [mozharness: 2017-08-07 11:36:58.355258Z] Running create-virtualenv step. 04:36:58 INFO - Running pre-action listener: _resource_record_pre_action 04:36:58 INFO - Running main action method: create_virtualenv 04:36:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:58 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:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:36:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:58 INFO - Using real prefix '/usr' 04:36:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:00 INFO - Installing pip.................done. 04:37:00 INFO - Return code: 0 04:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:37:01 INFO - Reading from file tmpfile_stdout 04:37:01 INFO - Output received: 04:37:01 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:37:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:37:01 INFO - Using env: {'DISPLAY': ':0', 04:37:01 INFO - 'HOME': '/home/cltbld', 04:37:01 INFO - 'LANG': 'en_US.UTF-8', 04:37:01 INFO - 'LANGUAGE': 'en_US:en', 04:37:01 INFO - 'LOGNAME': 'cltbld', 04:37:01 INFO - 'MAIL': '/var/mail/cltbld', 04:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:01 INFO - 'MOZ_NO_REMOTE': '1', 04:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:01 INFO - 'NO_EM_RESTART': '1', 04:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:01 INFO - 'PWD': '/builds/slave/test', 04:37:01 INFO - 'SHELL': '/bin/bash', 04:37:01 INFO - 'SHLVL': '1', 04:37:01 INFO - 'TERM': 'linux', 04:37:01 INFO - 'TMOUT': '86400', 04:37:01 INFO - 'USER': 'cltbld', 04:37:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:01 INFO - '_': '/tools/buildbot/bin/python'} 04:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:01 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:37:01 INFO - Cleaning up... 04:37:01 INFO - Return code: 0 04:37:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:37:01 INFO - Using env: {'DISPLAY': ':0', 04:37:01 INFO - 'HOME': '/home/cltbld', 04:37:01 INFO - 'LANG': 'en_US.UTF-8', 04:37:01 INFO - 'LANGUAGE': 'en_US:en', 04:37:01 INFO - 'LOGNAME': 'cltbld', 04:37:01 INFO - 'MAIL': '/var/mail/cltbld', 04:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:01 INFO - 'MOZ_NO_REMOTE': '1', 04:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:01 INFO - 'NO_EM_RESTART': '1', 04:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:01 INFO - 'PWD': '/builds/slave/test', 04:37:01 INFO - 'SHELL': '/bin/bash', 04:37:01 INFO - 'SHLVL': '1', 04:37:01 INFO - 'TERM': 'linux', 04:37:01 INFO - 'TMOUT': '86400', 04:37:01 INFO - 'USER': 'cltbld', 04:37:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:01 INFO - '_': '/tools/buildbot/bin/python'} 04:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:01 INFO - Downloading/unpacking psutil>=3.1.1 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:04 INFO - Installing collected packages: psutil 04:37:04 INFO - Running setup.py install for psutil 04:37:04 INFO - building 'psutil._psutil_linux' extension 04:37:04 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:37:04 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:37:04 INFO - building 'psutil._psutil_posix' extension 04:37:04 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:37:04 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:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:04 INFO - Successfully installed psutil 04:37:04 INFO - Cleaning up... 04:37:04 INFO - Return code: 0 04:37:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:37:04 INFO - Using env: {'DISPLAY': ':0', 04:37:04 INFO - 'HOME': '/home/cltbld', 04:37:04 INFO - 'LANG': 'en_US.UTF-8', 04:37:04 INFO - 'LANGUAGE': 'en_US:en', 04:37:04 INFO - 'LOGNAME': 'cltbld', 04:37:04 INFO - 'MAIL': '/var/mail/cltbld', 04:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:04 INFO - 'MOZ_NO_REMOTE': '1', 04:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:04 INFO - 'NO_EM_RESTART': '1', 04:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:04 INFO - 'PWD': '/builds/slave/test', 04:37:04 INFO - 'SHELL': '/bin/bash', 04:37:04 INFO - 'SHLVL': '1', 04:37:04 INFO - 'TERM': 'linux', 04:37:04 INFO - 'TMOUT': '86400', 04:37:04 INFO - 'USER': 'cltbld', 04:37:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:04 INFO - '_': '/tools/buildbot/bin/python'} 04:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:06 INFO - Installing collected packages: mozsystemmonitor 04:37:06 INFO - Running setup.py install for mozsystemmonitor 04:37:06 INFO - Successfully installed mozsystemmonitor 04:37:06 INFO - Cleaning up... 04:37:06 INFO - Return code: 0 04:37:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37:06 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:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:06 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:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:06 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:06 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:37:06 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:37:06 INFO - Using env: {'DISPLAY': ':0', 04:37:06 INFO - 'HOME': '/home/cltbld', 04:37:06 INFO - 'LANG': 'en_US.UTF-8', 04:37:06 INFO - 'LANGUAGE': 'en_US:en', 04:37:06 INFO - 'LOGNAME': 'cltbld', 04:37:06 INFO - 'MAIL': '/var/mail/cltbld', 04:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:06 INFO - 'MOZ_NO_REMOTE': '1', 04:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:06 INFO - 'NO_EM_RESTART': '1', 04:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:06 INFO - 'PWD': '/builds/slave/test', 04:37:06 INFO - 'SHELL': '/bin/bash', 04:37:06 INFO - 'SHLVL': '1', 04:37:06 INFO - 'TERM': 'linux', 04:37:06 INFO - 'TMOUT': '86400', 04:37:06 INFO - 'USER': 'cltbld', 04:37:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:06 INFO - '_': '/tools/buildbot/bin/python'} 04:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:06 INFO - Downloading/unpacking jsonschema==2.5.1 04:37:06 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:37:06 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:37:06 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:37:06 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:37:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37:08 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:37:08 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:37:08 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:37:08 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:37:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:08 INFO - warning: no files found matching '*.txt' 04:37:08 INFO - no previously-included directories found matching 'build' 04:37:08 INFO - no previously-included directories found matching 'dist' 04:37:08 INFO - no previously-included directories found matching '.git*' 04:37:08 INFO - Installing collected packages: jsonschema, functools32 04:37:08 INFO - Running setup.py install for functools32 04:37:08 INFO - warning: no files found matching '*.txt' 04:37:08 INFO - no previously-included directories found matching 'build' 04:37:08 INFO - no previously-included directories found matching 'dist' 04:37:08 INFO - no previously-included directories found matching '.git*' 04:37:08 INFO - Successfully installed jsonschema functools32 04:37:08 INFO - Cleaning up... 04:37:08 INFO - Return code: 0 04:37:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:37: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:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37: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:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:08 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:08 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:37:08 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:37:08 INFO - Using env: {'DISPLAY': ':0', 04:37:08 INFO - 'HOME': '/home/cltbld', 04:37:08 INFO - 'LANG': 'en_US.UTF-8', 04:37:08 INFO - 'LANGUAGE': 'en_US:en', 04:37:08 INFO - 'LOGNAME': 'cltbld', 04:37:08 INFO - 'MAIL': '/var/mail/cltbld', 04:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:08 INFO - 'MOZ_NO_REMOTE': '1', 04:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:08 INFO - 'NO_EM_RESTART': '1', 04:37:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:08 INFO - 'PWD': '/builds/slave/test', 04:37:08 INFO - 'SHELL': '/bin/bash', 04:37:08 INFO - 'SHLVL': '1', 04:37:08 INFO - 'TERM': 'linux', 04:37:08 INFO - 'TMOUT': '86400', 04:37:08 INFO - 'USER': 'cltbld', 04:37:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:08 INFO - '_': '/tools/buildbot/bin/python'} 04:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:37:08 INFO - Cleaning up... 04:37:08 INFO - Return code: 0 04:37:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37: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:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37: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:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:09 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:09 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:37:09 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:37:09 INFO - Using env: {'DISPLAY': ':0', 04:37:09 INFO - 'HOME': '/home/cltbld', 04:37:09 INFO - 'LANG': 'en_US.UTF-8', 04:37:09 INFO - 'LANGUAGE': 'en_US:en', 04:37:09 INFO - 'LOGNAME': 'cltbld', 04:37:09 INFO - 'MAIL': '/var/mail/cltbld', 04:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:09 INFO - 'MOZ_NO_REMOTE': '1', 04:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:09 INFO - 'NO_EM_RESTART': '1', 04:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:09 INFO - 'PWD': '/builds/slave/test', 04:37:09 INFO - 'SHELL': '/bin/bash', 04:37:09 INFO - 'SHLVL': '1', 04:37:09 INFO - 'TERM': 'linux', 04:37:09 INFO - 'TMOUT': '86400', 04:37:09 INFO - 'USER': 'cltbld', 04:37:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:09 INFO - '_': '/tools/buildbot/bin/python'} 04:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:09 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:37:09 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:37:09 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:37:09 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:37:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:10 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:37:10 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:37:10 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:37:10 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:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:10 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:37:10 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:37:10 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:37:10 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:37:11 INFO - Downloading docopt-0.6.1.tar.gz 04:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:11 INFO - Running setup.py install for blobuploader 04:37:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:11 INFO - Running setup.py install for requests 04:37:11 INFO - Running setup.py install for docopt 04:37:11 INFO - Successfully installed blobuploader requests docopt 04:37:11 INFO - Cleaning up... 04:37:11 INFO - Return code: 0 04:37:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:11 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:11 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:37:11 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:37:11 INFO - Using env: {'DISPLAY': ':0', 04:37:11 INFO - 'HOME': '/home/cltbld', 04:37:11 INFO - 'LANG': 'en_US.UTF-8', 04:37:11 INFO - 'LANGUAGE': 'en_US:en', 04:37:11 INFO - 'LOGNAME': 'cltbld', 04:37:11 INFO - 'MAIL': '/var/mail/cltbld', 04:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:11 INFO - 'MOZ_NO_REMOTE': '1', 04:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:11 INFO - 'NO_EM_RESTART': '1', 04:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:11 INFO - 'PWD': '/builds/slave/test', 04:37:11 INFO - 'SHELL': '/bin/bash', 04:37:11 INFO - 'SHLVL': '1', 04:37:11 INFO - 'TERM': 'linux', 04:37:11 INFO - 'TMOUT': '86400', 04:37:11 INFO - 'USER': 'cltbld', 04:37:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:11 INFO - '_': '/tools/buildbot/bin/python'} 04:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:12 INFO - Running setup.py (path:/tmp/pip-4g9yTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:12 INFO - Running setup.py (path:/tmp/pip-vMF6iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:12 INFO - Running setup.py (path:/tmp/pip-I2_6QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:12 INFO - Running setup.py (path:/tmp/pip-LqaavW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:12 INFO - Running setup.py (path:/tmp/pip-94sQ4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:12 INFO - Running setup.py (path:/tmp/pip-CznbXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:12 INFO - Running setup.py (path:/tmp/pip-cOB1Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:12 INFO - Running setup.py (path:/tmp/pip-3H_koz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:12 INFO - Running setup.py (path:/tmp/pip-H5NRxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:12 INFO - Running setup.py (path:/tmp/pip-hMWmAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:12 INFO - Running setup.py (path:/tmp/pip-WVSW83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:12 INFO - Running setup.py (path:/tmp/pip-fsgg7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:12 INFO - Running setup.py (path:/tmp/pip-QrFUOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:12 INFO - Running setup.py (path:/tmp/pip-ZCwSK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:13 INFO - Running setup.py (path:/tmp/pip-SOPZCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:13 INFO - Running setup.py (path:/tmp/pip-JMg5PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:13 INFO - Running setup.py (path:/tmp/pip-ng1l2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:13 INFO - Running setup.py install for manifestparser 04:37:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozcrash 04:37:13 INFO - Running setup.py install for mozdebug 04:37:13 INFO - Running setup.py install for mozdevice 04:37:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozfile 04:37:13 INFO - Running setup.py install for mozhttpd 04:37:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozinfo 04:37:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:13 INFO - Running setup.py install for mozInstall 04:37:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Running setup.py install for mozleak 04:37:14 INFO - Running setup.py install for mozlog 04:37:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Running setup.py install for moznetwork 04:37:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Running setup.py install for mozprocess 04:37:14 INFO - Running setup.py install for mozprofile 04:37:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Running setup.py install for mozrunner 04:37:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Running setup.py install for mozscreenshot 04:37:14 INFO - Running setup.py install for moztest 04:37:14 INFO - Running setup.py install for mozversion 04:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:14 INFO - Cleaning up... 04:37:15 INFO - Return code: 0 04:37:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:15 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:15 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:37:15 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:37:15 INFO - Using env: {'DISPLAY': ':0', 04:37:15 INFO - 'HOME': '/home/cltbld', 04:37:15 INFO - 'LANG': 'en_US.UTF-8', 04:37:15 INFO - 'LANGUAGE': 'en_US:en', 04:37:15 INFO - 'LOGNAME': 'cltbld', 04:37:15 INFO - 'MAIL': '/var/mail/cltbld', 04:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:15 INFO - 'MOZ_NO_REMOTE': '1', 04:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:15 INFO - 'NO_EM_RESTART': '1', 04:37:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:15 INFO - 'PWD': '/builds/slave/test', 04:37:15 INFO - 'SHELL': '/bin/bash', 04:37:15 INFO - 'SHLVL': '1', 04:37:15 INFO - 'TERM': 'linux', 04:37:15 INFO - 'TMOUT': '86400', 04:37:15 INFO - 'USER': 'cltbld', 04:37:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:15 INFO - '_': '/tools/buildbot/bin/python'} 04:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:15 INFO - Running setup.py (path:/tmp/pip-GqtnGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:15 INFO - Running setup.py (path:/tmp/pip-ZzJExp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:15 INFO - Running setup.py (path:/tmp/pip-rsxEPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:15 INFO - Running setup.py (path:/tmp/pip-FsdL6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:15 INFO - Running setup.py (path:/tmp/pip-u5PjJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:15 INFO - Running setup.py (path:/tmp/pip-zzX7FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:15 INFO - Running setup.py (path:/tmp/pip-u5hqAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:15 INFO - Running setup.py (path:/tmp/pip-UogEJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:15 INFO - Running setup.py (path:/tmp/pip-ingbUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:15 INFO - Running setup.py (path:/tmp/pip-RBN9nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:15 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:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:15 INFO - Running setup.py (path:/tmp/pip-pt8pnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:16 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:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:16 INFO - Running setup.py (path:/tmp/pip-D0hKa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:16 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:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:16 INFO - Running setup.py (path:/tmp/pip-t12m5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:16 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:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:16 INFO - Running setup.py (path:/tmp/pip-cQ4mmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:16 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:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:16 INFO - Running setup.py (path:/tmp/pip-eucIn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:16 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:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:16 INFO - Running setup.py (path:/tmp/pip-z6T2u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:16 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:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:16 INFO - Running setup.py (path:/tmp/pip-_tbUUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:16 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:37:16 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:37:16 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:37:16 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:37:16 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:37:16 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:37:16 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:37:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37: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:37: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:37: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:37: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:37:17 INFO - Downloading blessings-1.6.tar.gz 04:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:17 INFO - Installing collected packages: blessings 04:37:17 INFO - Running setup.py install for blessings 04:37:17 INFO - Successfully installed blessings 04:37:17 INFO - Cleaning up... 04:37:17 INFO - Return code: 0 04:37:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:18 INFO - Reading from file tmpfile_stdout 04:37:18 INFO - Current package versions: 04:37:18 INFO - argparse == 1.2.1 04:37:18 INFO - blessings == 1.6 04:37:18 INFO - blobuploader == 1.2.4 04:37:18 INFO - docopt == 0.6.1 04:37:18 INFO - functools32 == 3.2.3-2 04:37:18 INFO - jsonschema == 2.5.1 04:37:18 INFO - manifestparser == 1.1 04:37:18 INFO - mozInstall == 1.13 04:37:18 INFO - mozcrash == 1.0 04:37:18 INFO - mozdebug == 0.1 04:37:18 INFO - mozdevice == 0.51 04:37:18 INFO - mozfile == 1.2 04:37:18 INFO - mozhttpd == 0.7 04:37:18 INFO - mozinfo == 0.10 04:37:18 INFO - mozleak == 0.1 04:37:18 INFO - mozlog == 3.5 04:37:18 INFO - moznetwork == 0.27 04:37:18 INFO - mozprocess == 0.25 04:37:18 INFO - mozprofile == 0.28 04:37:18 INFO - mozrunner == 6.13 04:37:18 INFO - mozscreenshot == 0.1 04:37:18 INFO - mozsystemmonitor == 0.3 04:37:18 INFO - moztest == 0.8 04:37:18 INFO - mozversion == 1.4 04:37:18 INFO - psutil == 3.1.1 04:37:18 INFO - requests == 1.2.3 04:37:18 INFO - wsgiref == 0.1.2 04:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:18 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:18 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:37:18 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:37:18 INFO - Using env: {'DISPLAY': ':0', 04:37:18 INFO - 'HOME': '/home/cltbld', 04:37:18 INFO - 'LANG': 'en_US.UTF-8', 04:37:18 INFO - 'LANGUAGE': 'en_US:en', 04:37:18 INFO - 'LOGNAME': 'cltbld', 04:37:18 INFO - 'MAIL': '/var/mail/cltbld', 04:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:18 INFO - 'MOZ_NO_REMOTE': '1', 04:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:18 INFO - 'NO_EM_RESTART': '1', 04:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:18 INFO - 'PWD': '/builds/slave/test', 04:37:18 INFO - 'SHELL': '/bin/bash', 04:37:18 INFO - 'SHLVL': '1', 04:37:18 INFO - 'TERM': 'linux', 04:37:18 INFO - 'TMOUT': '86400', 04:37:18 INFO - 'USER': 'cltbld', 04:37:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:18 INFO - '_': '/tools/buildbot/bin/python'} 04:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 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:37:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:37:19 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:37:19 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:37:19 INFO - Installing collected packages: simplejson 04:37:19 INFO - Running setup.py install for simplejson 04:37:19 INFO - building 'simplejson._speedups' extension 04:37:19 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:37:20 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:37:20 INFO - Successfully installed simplejson 04:37:20 INFO - Cleaning up... 04:37:20 INFO - Return code: 0 04:37:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:20 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 0x23df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', '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:37:20 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:37:20 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:37:20 INFO - Using env: {'DISPLAY': ':0', 04:37:20 INFO - 'HOME': '/home/cltbld', 04:37:20 INFO - 'LANG': 'en_US.UTF-8', 04:37:20 INFO - 'LANGUAGE': 'en_US:en', 04:37:20 INFO - 'LOGNAME': 'cltbld', 04:37:20 INFO - 'MAIL': '/var/mail/cltbld', 04:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:20 INFO - 'MOZ_NO_REMOTE': '1', 04:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:20 INFO - 'NO_EM_RESTART': '1', 04:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:20 INFO - 'PWD': '/builds/slave/test', 04:37:20 INFO - 'SHELL': '/bin/bash', 04:37:20 INFO - 'SHLVL': '1', 04:37:20 INFO - 'TERM': 'linux', 04:37:20 INFO - 'TMOUT': '86400', 04:37:20 INFO - 'USER': 'cltbld', 04:37:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:20 INFO - '_': '/tools/buildbot/bin/python'} 04:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:21 INFO - Cleaning up... 04:37:21 INFO - Return code: 0 04:37:21 INFO - Running post-action listener: _resource_record_post_action 04:37:21 INFO - Running post-action listener: _start_resource_monitoring 04:37:21 INFO - Starting resource monitoring. 04:37:21 INFO - [mozharness: 2017-08-07 11:37:21.127527Z] Finished create-virtualenv step (success) 04:37:21 INFO - [mozharness: 2017-08-07 11:37:21.127996Z] Running install step. 04:37:21 INFO - Running pre-action listener: _resource_record_pre_action 04:37:21 INFO - Running main action method: install 04:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:21 INFO - Reading from file tmpfile_stdout 04:37:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:21 INFO - Reading from file tmpfile_stdout 04:37:21 INFO - Output received: 04:37:21 INFO - Usage: mozinstall [options] installer 04:37:21 INFO - Options: 04:37:21 INFO - -h, --help show this help message and exit 04:37:21 INFO - -d DEST, --destination=DEST 04:37:21 INFO - Directory to install application into. [default: 04:37:21 INFO - "/builds/slave/test"] 04:37:21 INFO - --app=APP Application being installed. [default: firefox] 04:37:21 INFO - mkdir: /builds/slave/test/build/application 04:37:21 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:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:37:39 INFO - Reading from file tmpfile_stdout 04:37:39 INFO - Output received: 04:37:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:39 INFO - Running post-action listener: _resource_record_post_action 04:37:39 INFO - [mozharness: 2017-08-07 11:37:39.387228Z] Finished install step (success) 04:37:39 INFO - [mozharness: 2017-08-07 11:37:39.387516Z] Running setup-mitmproxy step. 04:37:39 INFO - Running pre-action listener: _resource_record_pre_action 04:37:39 INFO - Running main action method: setup_mitmproxy 04:37:39 INFO - Skipping: mitmproxy is not required 04:37:39 INFO - Running post-action listener: _resource_record_post_action 04:37:39 INFO - [mozharness: 2017-08-07 11:37:39.388669Z] Finished setup-mitmproxy step (success) 04:37:39 INFO - [mozharness: 2017-08-07 11:37:39.388892Z] Running run-tests step. 04:37:39 INFO - Running pre-action listener: _resource_record_pre_action 04:37:39 INFO - Running pre-action listener: _set_gcov_prefix 04:37:39 INFO - Running main action method: run_tests 04:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:39 INFO - Python 2.7.3 04:37:39 INFO - Return code: 0 04:37:39 INFO - grabbing minidump binary from tooltool 04:37:39 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:37:39 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 0x274beb0>, '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 0x274cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274d240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:39 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:37:39 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:37:39 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:37:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:39 INFO - Return code: 0 04:37:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:39 INFO - ENV: RUST_BACKTRACE is now 1 04:37:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:39 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-061', '--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:37:39 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-061 --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:37:39 INFO - Using env: {'DISPLAY': ':0', 04:37:39 INFO - 'HOME': '/home/cltbld', 04:37:39 INFO - 'LANG': 'en_US.UTF-8', 04:37:39 INFO - 'LANGUAGE': 'en_US:en', 04:37:39 INFO - 'LOGNAME': 'cltbld', 04:37:39 INFO - 'MAIL': '/var/mail/cltbld', 04:37:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:39 INFO - 'MOZ_NO_REMOTE': '1', 04:37:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:39 INFO - 'NO_EM_RESTART': '1', 04:37:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:39 INFO - 'PWD': '/builds/slave/test', 04:37:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:39 INFO - 'RUST_BACKTRACE': '1', 04:37:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:37:39 INFO - 'SHELL': '/bin/bash', 04:37:39 INFO - 'SHLVL': '1', 04:37:39 INFO - 'STYLO_FORCE_ENABLED': '1', 04:37:39 INFO - 'TERM': 'linux', 04:37:39 INFO - 'TMOUT': '86400', 04:37:39 INFO - 'USER': 'cltbld', 04:37:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218', 04:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:39 INFO - '_': '/tools/buildbot/bin/python'} 04:37:39 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-061', '--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:37:39 INFO - mozversion application_buildid: 20170807105046 04:37:39 INFO - mozversion application_changeset: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 04:37:39 INFO - mozversion application_display_name: Nightly 04:37:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:39 INFO - mozversion application_name: Firefox 04:37:39 INFO - mozversion application_remotingname: firefox 04:37:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:39 INFO - mozversion application_vendor: Mozilla 04:37:39 INFO - mozversion application_version: 57.0a1 04:37:39 INFO - mozversion platform_buildid: 20170807105046 04:37:39 INFO - mozversion platform_changeset: 347ea0d06092d7fcd6c34e2c7ade389b0b71ae31 04:37:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:39 INFO - mozversion platform_version: 57.0a1 04:37:39 INFO - using testdate: 1502105859 04:37:39 INFO - actual date: 1502105859 04:37:39 INFO - starting webserver on 'localhost:44037' 04:37:39 INFO - SUITE-START | Running 2 tests 04:37:39 INFO - TEST-START | dromaeo_css 04:37:39 INFO - Initialising browser for dromaeo_css test... 04:37:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44037/getInfo.html -profile /tmp/tmppvqrbM/profile 04:37:39 INFO - TEST-INFO | started process 32555 (/builds/slave/test/build/application/firefox/firefox http://localhost:44037/getInfo.html) 04:37:45 INFO - TEST-INFO | 32555: exit 0 04:37:45 INFO - Browser initialized. 04:37:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:45 INFO - TEST-INFO | started process 311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppvqrbM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:46 INFO - PID 311 | 04:37:46 INFO - PID 311 | (/builds/slave/test/build/application/firefox/firefox:367): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:37:46 INFO - PID 311 | 04:37:57 INFO - PID 311 | RSS: Main: 174096384 04:37:57 INFO - PID 311 | 04:37:57 INFO - PID 311 | serialization: Helvetica 04:37:57 INFO - PID 311 | serialization: Arial 04:40:57 INFO - PID 311 | Cycle 1(1): loaded http://localhost:44037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44037/tests/dromaeo/cssquery-ext.html) 04:40:58 INFO - PID 311 | RSS: Main: 175697920 04:40:58 INFO - PID 311 | 04:40:58 INFO - PID 311 | serialization: Helvetica 04:40:58 INFO - PID 311 | serialization: Arial 04:44:00 INFO - PID 311 | Cycle 1(1): loaded http://localhost:44037/tests/dromaeo/cssquery-ext.html (next: http://localhost:44037/tests/dromaeo/cssquery-jquery.html) 04:44:00 INFO - PID 311 | RSS: Main: 173101056 04:44:00 INFO - PID 311 | 04:44:00 INFO - PID 311 | serialization: Helvetica 04:44:00 INFO - PID 311 | serialization: Arial 04:47:02 INFO - PID 311 | Cycle 1(1): loaded http://localhost:44037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44037/tests/dromaeo/cssquery-mootools.html) 04:47:03 INFO - PID 311 | RSS: Main: 175190016 04:47:03 INFO - PID 311 | 04:47:03 INFO - PID 311 | serialization: Helvetica 04:47:03 INFO - PID 311 | serialization: Arial 04:50:05 INFO - PID 311 | Cycle 1(1): loaded http://localhost:44037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44037/tests/dromaeo/cssquery-prototype.html) 04:50:05 INFO - PID 311 | RSS: Main: 173731840 04:50:05 INFO - PID 311 | 04:50:05 INFO - PID 311 | serialization: Helvetica 04:50:05 INFO - PID 311 | serialization: Arial 04:53:09 INFO - PID 311 | Cycle 1(1): loaded http://localhost:44037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44037/tests/dromaeo/cssquery-yui.html) 04:53:10 INFO - PID 311 | RSS: Main: 176775168 04:53:10 INFO - PID 311 | 04:53:10 INFO - PID 311 | serialization: Helvetica 04:53:10 INFO - PID 311 | serialization: Arial 04:56:11 INFO - PID 311 | Cycle 1(1): loaded http://localhost:44037/tests/dromaeo/cssquery-yui.html (next: http://localhost:44037/tests/dromaeo/cssquery-dojo.html) 04:56:12 INFO - PID 311 | RSS: Main: 177463296 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | __start_tp_report 04:56:12 INFO - PID 311 | _x_x_mozilla_page_load 04:56:12 INFO - PID 311 | _x_x_mozilla_page_load_details 04:56:12 INFO - PID 311 | |i|pagename|runs| 04:56:12 INFO - PID 311 | |0;dojo.html;3183.188286986818;3204.070819462356;3219.5975503062114;3225.629052658945;3248.3990461764574;6152.446279834814;6281.937180628198;6304.96847515763;6318.810435686925;6344.143540622014;6172.22847144107;6277.937220627792;6278.30938596754;6300;6317.652529110897;5692.829215123543;5698.658080515162;5709.571782116337;5718.056520674105;5818.41815818419;5715.228444160048;5781.364049954502;5800.245968024151;5817.011108111631;5827.941720582782;5621.747021384007;5732.856678583069;5766.625169363978;5835.970820145914;5850.795222167225;5706.686132262724;5726.484616384545;5775.047117225653;5779.017567013618;5817.825465236049;5682.090865461548;5695.686737229451;5735.799247026376;5741.741621627037;5798.304203495608;5984.461398474158;6110.663913484756;6133.264008318985;6169.043798211284;6215.7513699451965;6649.069130321759;6677.8664426711675;6686.93313066868;6735.831604209885;6764.729410823561;6834.555753875982;6840.384365407137;6862.279460656609;6873.381395674413;6907.412869906064;6203.224596925339;6240.843978900564;6261.686915654199;6311.147995020659;6326.272478664966;6914.0666010088;6937.653117344214;7003.929960700328;7022.0520229769345;7027.086478757831;6519.6414197218655;6601.73593056282;6615.073889655452;6615.6030638161865;6615.933840661532;6685.832854178587;6686.3313668632745;6689.832754181087;6708.362705542965;6718.05947167397;6646.900296495556;6676.46588272937;6686.09737685416;6686.832829179212;6702.932970670328;6287.842803929847;6639;6704.664766761643;6739.427148692416;6743.831404214934;5389.892202156013;5462.972685136629;5478.315210598676;5478.616496845182;5499.945000550023;4667.9766601166775;4686.5782079613;4690.460597031317;4705;4728.243481043017;5831.562632802556;5902.498287645512;5911.231539899785;5915.733791979285;5921.792737254175;6610.636414997221;6749.932500675029;6758.357955994271;6838.14523184602;6845.5550389224545;5785.479306862402;5809.215755872903;5847.473727364472;5850.678212698257;5860.765569377262;5971.28344598651;5983.700814959235;6003.489703375175;6004.789832355847;6011.188489553854;6009.786854090045;6563.803085907431;6647.767328143492;6658.03458498515;6676.165479315086;6729.831754206184;6747;6758;6796.116504854337;6847.383735463832;6402.87194256103;6469.5794773339585;6518.348165183444;6588.7035083422315;6599.538032337882;6655.534112612071;6683.097781799394;6683.832904177434;6717.227518835396;6720.0591917132615;6791.490638202254;6801.353871382211;6865.5537390069485;6919.169699636076;6926.515143939876;6429.324920883427;6533.346665333429;6560.967195163994;6641.203055633355;6674.799756007327;6541.934580654132;6552.541322107407;6557.213134423709;6561.212654481302;6577.473802095725;6370.044493326038;6457.773977910939;6479.060536222127;6480.157579514633;6492.0261960706275;6610;6624.712477720012;6634.734610615715;6680.432163266177;6737.831554210988;6328.14570033058;6329.145565348619;6421.646809425526;6512.218533775977;6535.673216339069 04:56:12 INFO - PID 311 | |1;ext.html;837.7612380471567;860.2773670117102;890.0921060518274;895.5119459894353;1162.3781277016797;30796.538051929238;31321.530177047363;42297.7885110574;42918.35622465658;43056.13887722244;43233;43275.134497310035;43453.34819977703;43528.347074793906;43535;7776.727814526493;7855.489393189453;7935.920640793604;7949.880751788699;7990.600469976507;7792.220777922219;7907.960460197691;7908.762737117867;7911.129775724666;7915.445918785687;7837.8824317635;7849.293563579276;7907.288344049034;7923.12845586985;7925.405594580401;7856.450048496607;7886.053673559152;7886.6056697165195;7886.999999999971;7887.763367098996;7695.461317707763;7725.111612164561;7754.922450775476;7779.494332868346;7796.844063118706;38349.23301533954;38398.61601383978;38444.038899027466;38528;38660.806695966625;3583.7312201584987;3606.747527673064;3620.728445366608;3627.9818600907092;3631.4371272452813;30881.536776948364;31203;31226;31263;31296.687033129834;4761.6904901181315;5055.646104772667;5065.088284108859;5085.542301192911;5104;183707;184066;184580;185227;185254.99999999866;47804.7609761949;47863.76068119637;47893.76053119712;48243.276350854765;48454;50223.49776502188;50429;50619.74690126526;50694.74652626787;50948.745256274226;13434.261115638537;13770.24263665508;16285.511434656979;16593.91703041477;16609.83390166107;13265.734685306239;13530.594082177551;13581.320933953262;13588.864111358958;13595.796063059062;14600.707985840436;14649.633759156106;14675.266236688336;14703.926480367743;14719.043262187923;5810.593258471867;5849.561282903799;5858.443447872445;6033.9698301508215;6112;1002.223276960347;1004.9196064314838;1020.7499162705185;1021.933574317667;1028.2236911132047;23034.308970730905;23055.53888922212;23072.53854922892;23219.95510202045;23456.179033733737;1101.6915263726169;1109.1958330210532;1109.9167562432688;1120.0759373516719;1136.170595465315;12109.546854377531;12157.69605759863;15927.442539511061;16284;16642.08468534218;228393;231066;231512;231801;232038;57576;57920.71039644775;58230.417695823344;58247;58354;1442.6802853565873;1448.1311213272163;1476.1143314011508;1480.2820631993475;1498.7826765119214;27108.864455677594;27122.32194195161;27171.86414067917;27650.446991059664;27883.860580696968;37680.623193767715;37858.81070594629;37920.81039594785;38021.23957520889;38032;195063;198113;198846;199148;199931;35538.82230588831;38810.6118938807;38995.220095598495;39360.6063939357;39541.40687889626;46792.298115528974;48500.51499485101;48564.514354856;48663.513364865896;48707.512924870294;34592.82703586466;34800;34905.47641785324;34964.65035349614;35676.64323356733;34040.82979585086;34175.316493670485;34451.310973780885;34470;34885.82557087198;38178.236435270584;38331;38337.808310958266;38683.613163868;38802.80598596989;33602.49596256009;33632.49551256684;33803.3239335207;33811.492827607115;33963.320733585686;24315.270541883772;24493.58929517192;24748.401417850866;24834.50330993406;25180.370490737878 04:56:12 INFO - PID 311 | |2;jquery.html;563.9971800140999;566.9461401166888;568.9573282003851;588.8086371929123;610.6153123532174;21951.67072493912;22960.196393126243;23066.308010759705;23081.538369232625;23781.76218237817;26722.866385668043;26891.32771680709;27295.317617059532;27349.863250683768;27352.863235683843;6526.379993900584;6644.335566443366;6709.731610735565;6714.194296684404;6717.126773519436;5891.057430811071;6536.8038958831075;6555.737770489175;6564.474842012628;6565.113709649184;6519.706613202417;6527.249366322862;6537.411632953033;6548.312427195147;6550.181227346582;6532.085508028832;6538.509611779112;6539.50953678476;6540.901886471706;6543.607383556978;6054.334023257438;6076.635401875901;6078.665673387962;6084.695765211766;6102.664353460558;28902;29515.409691806042;29788.404231915458;29915.850420747975;30063;1888.3107665702057;1938.0890981238795;1939.4957311099215;1940.8835469871713;1943.067327682706;18870.15084321209;19404.320848770225;19499.805001950084;19635.41093767175;19642.214311427524;2367.5912831865185;2367.763223677636;2420.4311986683115;2428.490017096412;2531.46839163774;133762;139276;140107.5989240115;141167;141263;14424.639384015483;14769.556913292618;14858.554243372717;15028.549143525712;15402.306896189475;23233.88383058074;23873.04507819668;23880.044798207877;23907.16324928619;24035.879820600785;10371.429571373646;10475.319104258198;10542.631007914839;10698.679039628823;10744.140468762636;9779.853302200472;9850.50747462624;9923.1069203772;10019;10076.748081298027;9433.764155896157;9491.240700743923;9606.742415532344;9624.085711857362;9696.418214907128;2619.148776647597;2636.7231440698833;2655.48218097473;2731.726827317252;2794.4969905416815;958.6500927161675;968.9612415503301;981.3130808434124;989.8366769482955;994.8010397920444;19148.329808456914;23485.882570587037;24242.51514969691;24322.878385607957;24580.89385977635;1023.8516561573192;1053.3574519543072;1058;1061.490484567412;1071.464267866067;11132.332060076422;11248.212625116163;11309.773804524028;11521.193516453768;12577.371131443391;475794;481252;486057;493208;499612;110222.44888775505;111105.44447277873;111408;118929;119890.4005479967;1241.3172754984903;1251.355551890777;1281.263273617655;1283.2172374851334;1289.1427200911476;21244.787552124282;21343.25298614541;21429.678554822003;21482.99238106635;21548.569028619655;55267.44732552623;55418;56234;56345;57600;68672.6566367185;69110;69202.65398673176;69545.30454695388;70112.64943675249;14168.574942751733;14812.333444994785;14873.553793386216;14905.105693658415;14914.552563423114;23174.884125579265;23218.88390558104;23245;23368.532629347657;23871.641925370786;16782.412615558398;18246.45260642183;18507.074646267363;18731;18906;16645.750313745546;16917.74623380675;16926.15369231558;16935.91532042332;16964.915175424536;18504.629907402046;19458.708119378505;19531.33983611409;19591.80408195957;19724.605507889475;14782.852171478147;14880.330385132478;15010.399584016517;15021.774673380127;15036.849631503545;18413.539661508035;18449.446516604523;18537.90731046336;18587.535311617317;18771.624567508847 04:56:12 INFO - PID 311 | |3;mootools.html;1315.1648703073547;1371.958841234762;1376.6902446949434;1381.6338670252385;1386.4246337769819;13590.728185436297;13838.308084595756;14207.786883196748;14213.076150050252;14258.643533911658;14436.206008669518;14653.706925861476;14744.410223591043;14748.6312842179;14782.408703651869;2693.2862791360303;2759.11708253359;2761.130243973152;2761.3786897947903;2761.9447611047867;2619.1487766475875;2621.30535408117;2669.8264612800203;2748.0656576763895;2751.064638023072;2711.6745990481168;2712;2729.9044533441333;2743.8353698778137;2745.1490038088155;2570.3445621366527;2591.2355855022815;2592.4685439484956;2622.278873309836;2639.788816894644;2515.434027343833;2532.2403279016407;2554.6423500709916;2557.539642864284;2559.910403135881;13220;13364.866351336459;13372.799408008888;13381.26403047832;13395.665108372272;7469.439792015621;7620.580868052255;7630.2751238632245;7708.807279817994;7755.185705500954;4965.553100220961;5176.767045482962;5296.25852380667;5309.946900531023;5343.545798607123;1768.3545505890386;1770.1326350088493;1817.5183576352276;1827.826356496144;1833.1475863723433;23403.414914627272;23724.76275237243;23732.88133559321;23748.76251237483;23758.40603984897;6452.5805822622315;6462.32145624712;6589.901151482732;6679.933200668028;6798.116244888231;15797.842021579867;15905.125218112884;15908.602284942737;15914;15915.522534323989;7642.312191902755;7786.454948153575;7798.883016754753;7802.336801371947;7837.725679601187;6912.101426814583;6939.479539034593;7127.75052873147;7131.786046418616;7175.641217939082;5030.471800460972;5079.822206222764;5131.794728210904;5162.74186290684;5187.559057480081;1368.2884899852022;1415.1650526189599;1452.7675571908444;1496.3864815425623;1517.544736579022;900.5092224737534;919.6597259014208;923.607466826596;928.4243768863348;929.5352323838081;7761.844763104819;7896.763097107096;7961.363090952826;7972.641231144612;8064.596770161468;903.3541018172039;931.9068093190626;974.8245315843217;986.5757724178673;1029.0481304793036;5489.58828087895;5646.774129034792;5749;5763.366029736726;5841.620294680833;18879.150438230314;19591.510212244808;19633.116509757096;19645.901770491342;19731.112099955535;18835.246590136514;19153.52116197106;19344.32294869673;19374.903125484565;19404.417867464;10116.393016419039;10668.253222274521;10735.248532602798;10740.892591074145;10807.567697292021;7735.750984586374;8116.594170291343;8385.496870187808;8482.279006284534;8794.164554367326;16225;16917.15414229259;16946.915265423595;16965.04901936244;17062.061586612854;17093.914530427268;17242.827571724123;17313.56716082108;17319.567010824325;17365.913170434065;12668.239905605693;12849.743005140032;13095.21428714242;13096.083274170716;13196.14225075367;13084.80372794428;13106.737865242832;13249.072564920363;13274.07081504324;13276.668083297995;10675.51960161779;10827.40449275266;10855.077318428022;11055.115590752881;11301.43492825339;10076.395416275047;10108.696739097839;10169.644062457779;10356.067953884187;10558.947205263925;9243.86134207974;9330.673426430043;9568.76078098053;9698.36960597559;9746.9025309746;6687.264400915993;6790.253072162157;6812.625305608239;6831.2144103428745;6905.723771049102;7083.5041547091205;7237.312455316736;7250.129984401906;7262.491625586158;7285.052943117361 04:56:12 INFO - PID 311 | |4;prototype.html;508.78885262616006;513.1584201908868;525.0627629681019;530.4297879779239;535.7196300840989;6118.4799292060225;6169.321374648785;6170.938290617092;6176.907346389797;6232.937670623298;6159.199304090474;6172.148355493346;6173.814785556429;6234.625922444645;6238.781642642509;5131.409887862887;5148.176291793314;5157.381114266274;5158.509941555565;5173.275741396207;5038.6724862883975;5070.847874563769;5102.438731739506;5150.407703114133;5179.844604661847;4712.175369310374;4860.9756951215195;4862.319275301443;4937.703737775727;4944.629152813535;4872.342233798445;4876.634252431064;4884.5603895649565;4934.235193545006;4953.257011448276;4369.3227549729845;4424.823007079713;4426.756528390937;4430.800613972379;4447.866564003053;5970;5981.611195272293;6019.367966363557;6027.819165425044;6058.545609079337;5598.3282006159525;5653.321601407816;5686.715664216814;5692.31692196939;5713.114467257582;6435.259945106326;6500.674966251669;6519.478441724651;6545;6549.8537755893;4824.348712923746;4831.130396528623;4860.989683511118;4870.780814863339;4873.098476781806;6441.484681225491;6669.266380698119;6734.393904548614;6831.965840170817;6922.653867306614;5282.3661160660195;5368.7047212403695;5432.674039557639;5468.972655136698;5492.340919089735;5343.599230057761;5472.124460086367;5508.586855985817;5531.474509921551;5581.302337207849;5917.704114794243;5930.140129681172;5934.347221805598;5938.940610593839;5973.37279585646;6525;6568.770093046721;6589.835254118685;6620.2386725527185;6630.635315057718;1927.1038966880467;1960.2551030608563;1966.3511041356603;1970.4187264756931;1975.664137096697;1384.9861501384858;1437.1951707044088;1442.293276294629;1453.8691517763452;1458.3874772595536;5672.035753921843;5784;5785.450382213683;5798.478136967693;5879.559033072536;6641.169853768279;6678.46395329077;6686.933130668728;6733.3266673333255;6775.796726098225;5724.971375143097;5766.731319109789;5770.538356931435;5812.9709351452975;5825.106840276927;3546.262331457567;3561.519194908706;3579.928401431957;3596.3346780845627;3597.4963505109304;6385.233771947396;6409.327020662763;6456.321356447357;6465.967670161714;6489.967550162313;6813.148356455443;6846.691898864563;6847.691853866588;6856.811582614108;6901.723931042802;6401.231852177769;6437.774677886251;6465;6476.6114033158165;6529.767764956282;6671.966640166768;6742.6291553965;6745.696443659949;6748.831279218059;6749.527533072638;6539.509536784855;6573.638449885111;6615.5038372123245;6644.734210631521;6652.667366631746;6378.617282963037;6456.741730330734;6494.967525162533;6506.512011599054;6514.674266286762;5385.515303622693;5385.676859388449;5399;5428.4842939920645;5451.918221226764;6351.618902865843;6641.601503909781;6681.265060843206;6732.360425759545;6773.830654233683;5912.70436478183;6294.339094395023;6402.423781859655;6411.230652321565;6494.383033611799;6351.71417286214;6373;6377.93622063792;6383.904241436289;6474.928023032584;6322.589031712924;6364.713587888464;6368.968155159195;6386.211860679017;6406.583572067801;6458.806235812933;6550.6069635822005;6589.24223714279;6595.307492713196;6616.933830661632;6309.463695585927;6311.779087731908;6392.68036598159;6396.264429590657;6415.1981002374705 04:56:12 INFO - PID 311 | |5;yui.html;824.1387749801457;829.5478963964639;849.7153453593046;878.446578655447;892.6474042753113;18048.90975545122;18287.81712182878;18308.90845545772;18327.908360458212;18419.079046047693;16480.587985300375;16912.746308805377;18695.3456629018;19154.233830646794;22291;1018.0735530667076;1046.0689985912543;1047.3192424923784;1049.1292227451236;1050.789842031593;1052.9578816847318;1053.2311412668757;1053.2995557953952;1053.9051485366315;1058.2327812336073;990.6285143071349;1083.56657337065;1092.1863211907141;1092.7158938675962;1108.6452335252723;1074.9895098607324;1076.6985244131656;1077.849101125843;1079.7732476179933;1082.8105081610686;805.4160733468248;805.605253425823;805.8066064144622;806.0649646410195;806.1938061938062;18989.33537326201;20666.689999650018;20890.791092089188;20897.164113435443;20938.89530552353;18751.249950001984;19155.233790648497;19452.319168829024;19492.31776887802;19629.901850490656;16661;16681.91659041709;16747.24637391308;16765.329386824513;16963.91518042414;3664.1572438339063;3692.7230457715777;3694.4458331250257;3694.9815250923843;3697.6856967157823;117124;119170.40414797957;119821.40089299585;123801.38099309536;125847.3707631456;16899.32402703878;17776.377826776;17792.288308467774;17801.109944502725;17887.910560447373;30820.69179308223;31400;31747;31779.52330715041;31825.68174318227;9025;9032.593533291018;9055.592498337459;9072.092790721008;9092.27261819053;4217.599328063829;4313.288307429302;4318.114786468766;4328.307470804656;4332.068605249887;4921.557059864629;5037;5066.442691303953;5087.6947383156385;5090.08378491875;1057.2493529594074;1089.700332408594;1090.2095980414294;1094.5074716377662;1106.5076041161606;568.3407247592772;569.1519635742796;575.0827430248746;579.160217684351;591.6361437715774;10903.29128606638;11096.500657470271;11535.480903359368;11608.883911160949;11891.762164756656;581.4272941152961;582.0745015425409;582.3739480058954;586.2291087220292;594.9524038076944;4885.682430642068;4919.557239848431;4938.25926111079;4943.802247910044;5090.898182036339;99627;99914;102582.48708756408;106423;107959.46020269848;88991.55504222437;93283;93315;95029;95135;69940.6502967482;76534.61732691301;78595.60702196452;81830.59084704658;84010.15989840146;11230.775384492428;11274;11357.256468171316;11408.087353011573;11768.70578235551;35427.645723543465;35545.82227088848;36402.27195456129;36587.63412365949;38496.80751596224;45387.773061135806;45548.26710397387;46477.302840456745;46869;47940.520594793605;15440.382384704486;15444.22778861075;15486.457973970857;15537.378504859678;15790.526284211492;16259.837401625833;16300.67398652044;16514.504564863073;16596.50210493687;16638;15913.443029493912;16196.352145914032;16199.190040498164;16243.59391015234;16439.589010274838;16000.439984600484;16174.838251617333;16253.59366015859;16300.67398652044;16551.50345489589;15853.286602102702;16634.58413539671;17104.401345952832;17131.486055418358;17207.13964301755;11745.765084698429;12119.272843629411;12160.391980401122;12442.129050966707;12677.429515671633;12724.91838193764;13281;13352.666183345495;13719.657008574466;14143.64640883986 04:56:12 INFO - PID 311 | __end_tp_report 04:56:12 INFO - PID 311 | __start_cc_report 04:56:12 INFO - PID 311 | _x_x_mozilla_cycle_collect,390 04:56:12 INFO - PID 311 | __end_cc_report 04:56:12 INFO - PID 311 | __startTimestamp1502106972153__endTimestamp 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | ------- Summary: start ------- 04:56:12 INFO - PID 311 | Number of tests: 6 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | [#0] dojo.html Cycles:165 Average:6203.89 Median:6429.32 stddev:728.28 (11.3%) stddev-sans-first:690.89 04:56:12 INFO - PID 311 | Values: 3183.2 3204.1 3219.6 3225.6 3248.4 6152.4 6281.9 6305.0 6318.8 6344.1 6172.2 6277.9 6278.3 6300.0 6317.7 5692.8 5698.7 5709.6 5718.1 5818.4 5715.2 5781.4 5800.2 5817.0 5827.9 5621.7 5732.9 5766.6 5836.0 5850.8 5706.7 5726.5 5775.0 5779.0 5817.8 5682.1 5695.7 5735.8 5741.7 5798.3 5984.5 6110.7 6133.3 6169.0 6215.8 6649.1 6677.9 6686.9 6735.8 6764.7 6834.6 6840.4 6862.3 6873.4 6907.4 6203.2 6240.8 6261.7 6311.1 6326.3 6914.1 6937.7 7003.9 7022.1 7027.1 6519.6 6601.7 6615.1 6615.6 6615.9 6685.8 6686.3 6689.8 6708.4 6718.1 6646.9 6676.5 6686.1 6686.8 6702.9 6287.8 6639.0 6704.7 6739.4 6743.8 5389.9 5463.0 5478.3 5478.6 5499.9 4668.0 4686.6 4690.5 4705.0 4728.2 5831.6 5902.5 5911.2 5915.7 5921.8 6610.6 6749.9 6758.4 6838.1 6845.6 5785.5 5809.2 5847.5 5850.7 5860.8 5971.3 5983.7 6003.5 6004.8 6011.2 6009.8 6563.8 6647.8 6658.0 6676.2 6729.8 6747.0 6758.0 6796.1 6847.4 6402.9 6469.6 6518.3 6588.7 6599.5 6655.5 6683.1 6683.8 6717.2 6720.1 6791.5 6801.4 6865.6 6919.2 6926.5 6429.3 6533.3 6561.0 6641.2 6674.8 6541.9 6552.5 6557.2 6561.2 6577.5 6370.0 6457.8 6479.1 6480.2 6492.0 6610.0 6624.7 6634.7 6680.4 6737.8 6328.1 6329.1 6421.6 6512.2 6535.7 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | [#1] ext.html Cycles:180 Average:38322.69 Median:3613.74 stddev:53195.25 (1472.0%) stddev-sans-first:53270.01 04:56:12 INFO - PID 311 | Values: 837.8 860.3 890.1 895.5 1162.4 30796.5 31321.5 42297.8 42918.4 43056.1 43233.0 43275.1 43453.3 43528.3 43535.0 7776.7 7855.5 7935.9 7949.9 7990.6 7792.2 7908.0 7908.8 7911.1 7915.4 7837.9 7849.3 7907.3 7923.1 7925.4 7856.5 7886.1 7886.6 7887.0 7887.8 7695.5 7725.1 7754.9 7779.5 7796.8 38349.2 38398.6 38444.0 38528.0 38660.8 3583.7 3606.7 3620.7 3628.0 3631.4 30881.5 31203.0 31226.0 31263.0 31296.7 4761.7 5055.6 5065.1 5085.5 5104.0 183707.0 184066.0 184580.0 185227.0 185255.0 47804.8 47863.8 47893.8 48243.3 48454.0 50223.5 50429.0 50619.7 50694.7 50948.7 13434.3 13770.2 16285.5 16593.9 16609.8 13265.7 13530.6 13581.3 13588.9 13595.8 14600.7 14649.6 14675.3 14703.9 14719.0 5810.6 5849.6 5858.4 6034.0 6112.0 1002.2 1004.9 1020.7 1021.9 1028.2 23034.3 23055.5 23072.5 23220.0 23456.2 1101.7 1109.2 1109.9 1120.1 1136.2 12109.5 12157.7 15927.4 16284.0 16642.1 228393.0 231066.0 231512.0 231801.0 232038.0 57576.0 57920.7 58230.4 58247.0 58354.0 1442.7 1448.1 1476.1 1480.3 1498.8 27108.9 27122.3 27171.9 27650.4 27883.9 37680.6 37858.8 37920.8 38021.2 38032.0 195063.0 198113.0 198846.0 199148.0 199931.0 35538.8 38810.6 38995.2 39360.6 39541.4 46792.3 48500.5 48564.5 48663.5 48707.5 34592.8 34800.0 34905.5 34964.7 35676.6 34040.8 34175.3 34451.3 34470.0 34885.8 38178.2 38331.0 38337.8 38683.6 38802.8 33602.5 33632.5 33803.3 33811.5 33963.3 24315.3 24493.6 24748.4 24834.5 25180.4 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | [#2] jquery.html Cycles:180 Average:34982.49 Median:23306.77 stddev:82059.23 (352.1%) stddev-sans-first:82248.73 04:56:12 INFO - PID 311 | Values: 564.0 566.9 569.0 588.8 610.6 21951.7 22960.2 23066.3 23081.5 23781.8 26722.9 26891.3 27295.3 27349.9 27352.9 6526.4 6644.3 6709.7 6714.2 6717.1 5891.1 6536.8 6555.7 6564.5 6565.1 6519.7 6527.2 6537.4 6548.3 6550.2 6532.1 6538.5 6539.5 6540.9 6543.6 6054.3 6076.6 6078.7 6084.7 6102.7 28902.0 29515.4 29788.4 29915.9 30063.0 1888.3 1938.1 1939.5 1940.9 1943.1 18870.2 19404.3 19499.8 19635.4 19642.2 2367.6 2367.8 2420.4 2428.5 2531.5 133762.0 139276.0 140107.6 141167.0 141263.0 14424.6 14769.6 14858.6 15028.5 15402.3 23233.9 23873.0 23880.0 23907.2 24035.9 10371.4 10475.3 10542.6 10698.7 10744.1 9779.9 9850.5 9923.1 10019.0 10076.7 9433.8 9491.2 9606.7 9624.1 9696.4 2619.1 2636.7 2655.5 2731.7 2794.5 958.7 969.0 981.3 989.8 994.8 19148.3 23485.9 24242.5 24322.9 24580.9 1023.9 1053.4 1058.0 1061.5 1071.5 11132.3 11248.2 11309.8 11521.2 12577.4 475794.0 481252.0 486057.0 493208.0 499612.0 110222.4 111105.4 111408.0 118929.0 119890.4 1241.3 1251.4 1281.3 1283.2 1289.1 21244.8 21343.3 21429.7 21483.0 21548.6 55267.4 55418.0 56234.0 56345.0 57600.0 68672.7 69110.0 69202.7 69545.3 70112.6 14168.6 14812.3 14873.6 14905.1 14914.6 23174.9 23218.9 23245.0 23368.5 23871.6 16782.4 18246.5 18507.1 18731.0 18906.0 16645.8 16917.7 16926.2 16935.9 16964.9 18504.6 19458.7 19531.3 19591.8 19724.6 14782.9 14880.3 15010.4 15021.8 15036.8 18413.5 18449.4 18537.9 18587.5 18771.6 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | [#3] mootools.html Cycles:180 Average:8808.14 Median:2565.13 stddev:5991.38 (233.6%) stddev-sans-first:5981.73 04:56:12 INFO - PID 311 | Values: 1315.2 1372.0 1376.7 1381.6 1386.4 13590.7 13838.3 14207.8 14213.1 14258.6 14436.2 14653.7 14744.4 14748.6 14782.4 2693.3 2759.1 2761.1 2761.4 2761.9 2619.1 2621.3 2669.8 2748.1 2751.1 2711.7 2712.0 2729.9 2743.8 2745.1 2570.3 2591.2 2592.5 2622.3 2639.8 2515.4 2532.2 2554.6 2557.5 2559.9 13220.0 13364.9 13372.8 13381.3 13395.7 7469.4 7620.6 7630.3 7708.8 7755.2 4965.6 5176.8 5296.3 5309.9 5343.5 1768.4 1770.1 1817.5 1827.8 1833.1 23403.4 23724.8 23732.9 23748.8 23758.4 6452.6 6462.3 6589.9 6679.9 6798.1 15797.8 15905.1 15908.6 15914.0 15915.5 7642.3 7786.5 7798.9 7802.3 7837.7 6912.1 6939.5 7127.8 7131.8 7175.6 5030.5 5079.8 5131.8 5162.7 5187.6 1368.3 1415.2 1452.8 1496.4 1517.5 900.5 919.7 923.6 928.4 929.5 7761.8 7896.8 7961.4 7972.6 8064.6 903.4 931.9 974.8 986.6 1029.0 5489.6 5646.8 5749.0 5763.4 5841.6 18879.2 19591.5 19633.1 19645.9 19731.1 18835.2 19153.5 19344.3 19374.9 19404.4 10116.4 10668.3 10735.2 10740.9 10807.6 7735.8 8116.6 8385.5 8482.3 8794.2 16225.0 16917.2 16946.9 16965.0 17062.1 17093.9 17242.8 17313.6 17319.6 17365.9 12668.2 12849.7 13095.2 13096.1 13196.1 13084.8 13106.7 13249.1 13274.1 13276.7 10675.5 10827.4 10855.1 11055.1 11301.4 10076.4 10108.7 10169.6 10356.1 10558.9 9243.9 9330.7 9568.8 9698.4 9746.9 6687.3 6790.3 6812.6 6831.2 6905.7 7083.5 7237.3 7250.1 7262.5 7285.1 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | [#4] prototype.html Cycles:180 Average:5537.99 Median:6088.51 stddev:1491.77 (24.5%) stddev-sans-first:1447.41 04:56:12 INFO - PID 311 | Values: 508.8 513.2 525.1 530.4 535.7 6118.5 6169.3 6170.9 6176.9 6232.9 6159.2 6172.1 6173.8 6234.6 6238.8 5131.4 5148.2 5157.4 5158.5 5173.3 5038.7 5070.8 5102.4 5150.4 5179.8 4712.2 4861.0 4862.3 4937.7 4944.6 4872.3 4876.6 4884.6 4934.2 4953.3 4369.3 4424.8 4426.8 4430.8 4447.9 5970.0 5981.6 6019.4 6027.8 6058.5 5598.3 5653.3 5686.7 5692.3 5713.1 6435.3 6500.7 6519.5 6545.0 6549.9 4824.3 4831.1 4861.0 4870.8 4873.1 6441.5 6669.3 6734.4 6832.0 6922.7 5282.4 5368.7 5432.7 5469.0 5492.3 5343.6 5472.1 5508.6 5531.5 5581.3 5917.7 5930.1 5934.3 5938.9 5973.4 6525.0 6568.8 6589.8 6620.2 6630.6 1927.1 1960.3 1966.4 1970.4 1975.7 1385.0 1437.2 1442.3 1453.9 1458.4 5672.0 5784.0 5785.5 5798.5 5879.6 6641.2 6678.5 6686.9 6733.3 6775.8 5725.0 5766.7 5770.5 5813.0 5825.1 3546.3 3561.5 3579.9 3596.3 3597.5 6385.2 6409.3 6456.3 6466.0 6490.0 6813.1 6846.7 6847.7 6856.8 6901.7 6401.2 6437.8 6465.0 6476.6 6529.8 6672.0 6742.6 6745.7 6748.8 6749.5 6539.5 6573.6 6615.5 6644.7 6652.7 6378.6 6456.7 6495.0 6506.5 6514.7 5385.5 5385.7 5399.0 5428.5 5451.9 6351.6 6641.6 6681.3 6732.4 6773.8 5912.7 6294.3 6402.4 6411.2 6494.4 6351.7 6373.0 6377.9 6383.9 6474.9 6322.6 6364.7 6369.0 6386.2 6406.6 6458.8 6550.6 6589.2 6595.3 6616.9 6309.5 6311.8 6392.7 6396.3 6415.2 04:56:12 INFO - PID 311 | 04:56:12 INFO - PID 311 | [#5] yui.html Cycles:180 Average:21842.33 Median:18298.36 stddev:29735.65 (162.5%) stddev-sans-first:29777.18 04:56:12 INFO - PID 311 | Values: 824.1 829.5 849.7 878.4 892.6 18048.9 18287.8 18308.9 18327.9 18419.1 16480.6 16912.7 18695.3 19154.2 22291.0 1018.1 1046.1 1047.3 1049.1 1050.8 1053.0 1053.2 1053.3 1053.9 1058.2 990.6 1083.6 1092.2 1092.7 1108.6 1075.0 1076.7 1077.8 1079.8 1082.8 805.4 805.6 805.8 806.1 806.2 18989.3 20666.7 20890.8 20897.2 20938.9 18751.2 19155.2 19452.3 19492.3 19629.9 16661.0 16681.9 16747.2 16765.3 16963.9 3664.2 3692.7 3694.4 3695.0 3697.7 117124.0 119170.4 119821.4 123801.4 125847.4 16899.3 17776.4 17792.3 17801.1 17887.9 30820.7 31400.0 31747.0 31779.5 31825.7 9025.0 9032.6 9055.6 9072.1 9092.3 4217.6 4313.3 4318.1 4328.3 4332.1 4921.6 5037.0 5066.4 5087.7 5090.1 1057.2 1089.7 1090.2 1094.5 1106.5 568.3 569.2 575.1 579.2 591.6 10903.3 11096.5 11535.5 11608.9 11891.8 581.4 582.1 582.4 586.2 595.0 4885.7 4919.6 4938.3 4943.8 5090.9 99627.0 99914.0 102582.5 106423.0 107959.5 88991.6 93283.0 93315.0 95029.0 95135.0 69940.7 76534.6 78595.6 81830.6 84010.2 11230.8 11274.0 11357.3 11408.1 11768.7 35427.6 35545.8 36402.3 36587.6 38496.8 45387.8 45548.3 46477.3 46869.0 47940.5 15440.4 15444.2 15486.5 15537.4 15790.5 16259.8 16300.7 16514.5 16596.5 16638.0 15913.4 16196.4 16199.2 16243.6 16439.6 16000.4 16174.8 16253.6 16300.7 16551.5 15853.3 16634.6 17104.4 17131.5 17207.1 11745.8 12119.3 12160.4 12442.1 12677.4 12724.9 13281.0 13352.7 13719.7 14143.6 04:56:12 INFO - PID 311 | -------- Summary: end -------- 04:56:12 INFO - PID 311 | 04:56:12 INFO - TEST-INFO | 311: exit 0 04:56:12 INFO - TEST-OK | dromaeo_css | took 1113138ms 04:56:12 INFO - TEST-START | kraken 04:56:12 INFO - Initialising browser for kraken test... 04:56:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44037/getInfo.html -profile /tmp/tmpDuTWzk/profile 04:56:12 INFO - TEST-INFO | started process 690 (/builds/slave/test/build/application/firefox/firefox http://localhost:44037/getInfo.html) 04:56:18 INFO - TEST-INFO | 690: exit 0 04:56:18 INFO - Browser initialized. 04:56:18 INFO - Running cycle 1/1 for kraken test... 04:56:18 INFO - TEST-INFO | started process 930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDuTWzk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:19 INFO - PID 930 | 04:56:19 INFO - PID 930 | (/builds/slave/test/build/application/firefox/firefox:985): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:56:19 INFO - PID 930 | 04:56:30 INFO - PID 930 | RSS: Main: 173142016 04:56:30 INFO - PID 930 | 04:56:30 INFO - PID 930 | serialization: Helvetica 04:56:30 INFO - PID 930 | serialization: Arial 04:56:33 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44037/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:33 INFO - PID 930 | RSS: Main: 178511872 04:56:33 INFO - PID 930 | 04:56:33 INFO - PID 930 | serialization: Helvetica 04:56:33 INFO - PID 930 | serialization: Arial 04:56:36 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44037/tests/kraken/driver.html?testName=audio-dft) 04:56:37 INFO - PID 930 | RSS: Main: 178798592 04:56:37 INFO - PID 930 | 04:56:37 INFO - PID 930 | serialization: Helvetica 04:56:37 INFO - PID 930 | serialization: Arial 04:56:40 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44037/tests/kraken/driver.html?testName=audio-fft) 04:56:41 INFO - PID 930 | RSS: Main: 173903872 04:56:41 INFO - PID 930 | 04:56:41 INFO - PID 930 | serialization: Helvetica 04:56:41 INFO - PID 930 | serialization: Arial 04:56:43 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44037/tests/kraken/driver.html?testName=audio-oscillator) 04:56:43 INFO - PID 930 | RSS: Main: 174288896 04:56:43 INFO - PID 930 | 04:56:43 INFO - PID 930 | serialization: Helvetica 04:56:43 INFO - PID 930 | serialization: Arial 04:56:46 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:46 INFO - PID 930 | RSS: Main: 174505984 04:56:46 INFO - PID 930 | 04:56:46 INFO - PID 930 | serialization: Helvetica 04:56:46 INFO - PID 930 | serialization: Arial 04:56:49 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44037/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:50 INFO - PID 930 | RSS: Main: 176840704 04:56:50 INFO - PID 930 | 04:56:50 INFO - PID 930 | serialization: Helvetica 04:56:50 INFO - PID 930 | serialization: Arial 04:56:54 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44037/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:54 INFO - PID 930 | RSS: Main: 176693248 04:56:54 INFO - PID 930 | 04:56:54 INFO - PID 930 | serialization: Helvetica 04:56:54 INFO - PID 930 | serialization: Arial 04:56:57 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44037/tests/kraken/driver.html?testName=json-parse-financial) 04:56:58 INFO - PID 930 | RSS: Main: 177676288 04:56:58 INFO - PID 930 | 04:56:58 INFO - PID 930 | serialization: Helvetica 04:56:58 INFO - PID 930 | serialization: Arial 04:56:59 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:00 INFO - PID 930 | RSS: Main: 177926144 04:57:00 INFO - PID 930 | 04:57:00 INFO - PID 930 | serialization: Helvetica 04:57:00 INFO - PID 930 | serialization: Arial 04:57:02 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:03 INFO - PID 930 | RSS: Main: 174804992 04:57:03 INFO - PID 930 | 04:57:03 INFO - PID 930 | serialization: Helvetica 04:57:03 INFO - PID 930 | serialization: Arial 04:57:05 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:06 INFO - PID 930 | RSS: Main: 174469120 04:57:06 INFO - PID 930 | 04:57:06 INFO - PID 930 | serialization: Helvetica 04:57:06 INFO - PID 930 | serialization: Arial 04:57:08 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:09 INFO - PID 930 | RSS: Main: 174784512 04:57:09 INFO - PID 930 | 04:57:09 INFO - PID 930 | serialization: Helvetica 04:57:09 INFO - PID 930 | serialization: Arial 04:57:12 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:13 INFO - PID 930 | RSS: Main: 174825472 04:57:13 INFO - PID 930 | 04:57:13 INFO - PID 930 | serialization: Helvetica 04:57:13 INFO - PID 930 | serialization: Arial 04:57:15 INFO - PID 930 | Cycle 1(1): loaded http://localhost:44037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44037/tests/kraken/driver.html?testName=ai-astar) 04:57:15 INFO - PID 930 | RSS: Main: 175788032 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | __start_tp_report 04:57:15 INFO - PID 930 | _x_x_mozilla_page_load 04:57:15 INFO - PID 930 | _x_x_mozilla_page_load_details 04:57:15 INFO - PID 930 | |i|pagename|runs| 04:57:15 INFO - PID 930 | |0;ai-astar;100;106;103;107;116;111;107;112;110;107 04:57:15 INFO - PID 930 | |1;audio-beat-detection;156;118;152;175;121;155;151;121;177;118 04:57:15 INFO - PID 930 | |2;audio-dft;163;170;163;163;166;168;166;162;161;163 04:57:15 INFO - PID 930 | |3;audio-fft;80;75;75;175;76;79;76;88;101;80 04:57:15 INFO - PID 930 | |4;audio-oscillator;79;79;135;79;80;85;124;82;83;132 04:57:15 INFO - PID 930 | |5;imaging-gaussian-blur;123;114;119;117;122;115;114;116;118;118 04:57:15 INFO - PID 930 | |6;imaging-darkroom;150;152;157;150;150;150;151;152;151;151 04:57:15 INFO - PID 930 | |7;imaging-desaturate;94;99;97;94;94;101;94;95;94;93 04:57:15 INFO - PID 930 | |8;json-parse-financial;59;56;61;62;58;55;58;56;67;55 04:57:15 INFO - PID 930 | |9;json-stringify-tinderbox;60;53;53;54;54;53;55;54;54;55 04:57:15 INFO - PID 930 | |10;stanford-crypto-aes;81;78;81;89;81;78;81;89;79;77 04:57:15 INFO - PID 930 | |11;stanford-crypto-ccm;132;129;142;123;132;125;134;126;127;180 04:57:15 INFO - PID 930 | |12;stanford-crypto-pbkdf2;189;175;179;186;178;177;186;174;176;174 04:57:15 INFO - PID 930 | |13;stanford-crypto-sha256-iterative;68;66;68;73;68;67;66;67;65;65 04:57:15 INFO - PID 930 | __end_tp_report 04:57:15 INFO - PID 930 | __start_cc_report 04:57:15 INFO - PID 930 | _x_x_mozilla_cycle_collect,949 04:57:15 INFO - PID 930 | __end_cc_report 04:57:15 INFO - PID 930 | __startTimestamp1502107035388__endTimestamp 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | ------- Summary: start ------- 04:57:15 INFO - PID 930 | Number of tests: 14 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.50 stddev:4.58 (4.2%) stddev-sans-first:3.87 04:57:15 INFO - PID 930 | Values: 100.0 106.0 103.0 107.0 116.0 111.0 107.0 112.0 110.0 107.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.50 stddev:23.18 (15.1%) stddev-sans-first:24.20 04:57:15 INFO - PID 930 | Values: 156.0 118.0 152.0 175.0 121.0 155.0 151.0 121.0 177.0 118.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.88 (1.7%) stddev-sans-first:3.00 04:57:15 INFO - PID 930 | Values: 163.0 170.0 163.0 163.0 166.0 168.0 166.0 162.0 161.0 163.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#3] audio-fft Cycles:10 Average:90.50 Median:77.50 stddev:30.75 (39.7%) stddev-sans-first:32.38 04:57:15 INFO - PID 930 | Values: 80.0 75.0 75.0 175.0 76.0 79.0 76.0 88.0 101.0 80.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.50 stddev:24.06 (30.3%) stddev-sans-first:24.74 04:57:15 INFO - PID 930 | Values: 79.0 79.0 135.0 79.0 80.0 85.0 124.0 82.0 83.0 132.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:3.10 (2.6%) stddev-sans-first:2.60 04:57:15 INFO - PID 930 | Values: 123.0 114.0 119.0 117.0 122.0 115.0 114.0 116.0 118.0 118.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:2.12 (1.4%) stddev-sans-first:2.19 04:57:15 INFO - PID 930 | Values: 150.0 152.0 157.0 150.0 150.0 150.0 151.0 152.0 151.0 151.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:94.00 stddev:2.64 (2.8%) stddev-sans-first:2.74 04:57:15 INFO - PID 930 | Values: 94.0 99.0 97.0 94.0 94.0 101.0 94.0 95.0 94.0 93.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.50 stddev:3.77 (6.4%) stddev-sans-first:4.00 04:57:15 INFO - PID 930 | Values: 59.0 56.0 61.0 62.0 58.0 55.0 58.0 56.0 67.0 55.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:2.07 (3.8%) stddev-sans-first:0.78 04:57:15 INFO - PID 930 | Values: 60.0 53.0 53.0 54.0 54.0 53.0 55.0 54.0 54.0 55.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:4.27 (5.3%) stddev-sans-first:4.53 04:57:15 INFO - PID 930 | Values: 81.0 78.0 81.0 89.0 81.0 78.0 81.0 89.0 79.0 77.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:132.00 stddev:16.73 (12.7%) stddev-sans-first:17.71 04:57:15 INFO - PID 930 | Values: 132.0 129.0 142.0 123.0 132.0 125.0 134.0 126.0 127.0 180.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:178.50 stddev:5.54 (3.1%) stddev-sans-first:4.66 04:57:15 INFO - PID 930 | Values: 189.0 175.0 179.0 186.0 178.0 177.0 186.0 174.0 176.0 174.0 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.31 (3.4%) stddev-sans-first:2.44 04:57:15 INFO - PID 930 | Values: 68.0 66.0 68.0 73.0 68.0 67.0 66.0 67.0 65.0 65.0 04:57:15 INFO - PID 930 | -------- Summary: end -------- 04:57:15 INFO - PID 930 | 04:57:15 INFO - PID 930 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:57:16 INFO - TEST-INFO | 930: exit 0 04:57:16 INFO - TEST-OK | kraken | took 63392ms 04:57:16 INFO - SUITE-END | took 1176s 04:57:16 INFO - Completed test suite (00:19:36) 04:57:16 INFO - javascript benchmark 04:57:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8508.283963302329, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.188286986818, 3204.070819462356, 3219.5975503062114, 3225.629052658945, 3248.3990461764574, 6152.446279834814, 6281.937180628198, 6304.96847515763, 6318.810435686925, 6344.143540622014, 6172.22847144107, 6277.937220627792, 6278.30938596754, 6300.0, 6317.652529110897, 5692.829215123543, 5698.658080515162, 5709.571782116337, 5718.056520674105, 5818.41815818419, 5715.228444160048, 5781.364049954502, 5800.245968024151, 5817.011108111631, 5827.941720582782, 5621.747021384007, 5732.856678583069, 5766.625169363978, 5835.970820145914, 5850.795222167225, 5706.686132262724, 5726.484616384545, 5775.047117225653, 5779.017567013618, 5817.825465236049, 5682.090865461548, 5695.686737229451, 5735.799247026376, 5741.741621627037, 5798.304203495608, 5984.461398474158, 6110.663913484756, 6133.264008318985, 6169.043798211284, 6215.7513699451965, 6649.069130321759, 6677.8664426711675, 6686.93313066868, 6735.831604209885, 6764.729410823561, 6834.555753875982, 6840.384365407137, 6862.279460656609, 6873.381395674413, 6907.412869906064, 6203.224596925339, 6240.843978900564, 6261.686915654199, 6311.147995020659, 6326.272478664966, 6914.0666010088, 6937.653117344214, 7003.929960700328, 7022.0520229769345, 7027.086478757831, 6519.6414197218655, 6601.73593056282, 6615.073889655452, 6615.6030638161865, 6615.933840661532, 6685.832854178587, 6686.3313668632745, 6689.832754181087, 6708.362705542965, 6718.05947167397, 6646.900296495556, 6676.46588272937, 6686.09737685416, 6686.832829179212, 6702.932970670328, 6287.842803929847, 6639.0, 6704.664766761643, 6739.427148692416, 6743.831404214934, 5389.892202156013, 5462.972685136629, 5478.315210598676, 5478.616496845182, 5499.945000550023, 4667.9766601166775, 4686.5782079613, 4690.460597031317, 4705.0, 4728.243481043017, 5831.562632802556, 5902.498287645512, 5911.231539899785, 5915.733791979285, 5921.792737254175, 6610.636414997221, 6749.932500675029, 6758.357955994271, 6838.14523184602, 6845.5550389224545, 5785.479306862402, 5809.215755872903, 5847.473727364472, 5850.678212698257, 5860.765569377262, 5971.28344598651, 5983.700814959235, 6003.489703375175, 6004.789832355847, 6011.188489553854, 6009.786854090045, 6563.803085907431, 6647.767328143492, 6658.03458498515, 6676.165479315086, 6729.831754206184, 6747.0, 6758.0, 6796.116504854337, 6847.383735463832, 6402.87194256103, 6469.5794773339585, 6518.348165183444, 6588.7035083422315, 6599.538032337882, 6655.534112612071, 6683.097781799394, 6683.832904177434, 6717.227518835396, 6720.0591917132615, 6791.490638202254, 6801.353871382211, 6865.5537390069485, 6919.169699636076, 6926.515143939876, 6429.324920883427, 6533.346665333429, 6560.967195163994, 6641.203055633355, 6674.799756007327, 6541.934580654132, 6552.541322107407, 6557.213134423709, 6561.212654481302, 6577.473802095725, 6370.044493326038, 6457.773977910939, 6479.060536222127, 6480.157579514633, 6492.0261960706275, 6610.0, 6624.712477720012, 6634.734610615715, 6680.432163266177, 6737.831554210988, 6328.14570033058, 6329.145565348619, 6421.646809425526, 6512.218533775977, 6535.673216339069], "value": 6150.072871549737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [837.7612380471567, 860.2773670117102, 890.0921060518274, 895.5119459894353, 1162.3781277016797, 30796.538051929238, 31321.530177047363, 42297.7885110574, 42918.35622465658, 43056.13887722244, 43233.0, 43275.134497310035, 43453.34819977703, 43528.347074793906, 43535.0, 7776.727814526493, 7855.489393189453, 7935.920640793604, 7949.880751788699, 7990.600469976507, 7792.220777922219, 7907.960460197691, 7908.762737117867, 7911.129775724666, 7915.445918785687, 7837.8824317635, 7849.293563579276, 7907.288344049034, 7923.12845586985, 7925.405594580401, 7856.450048496607, 7886.053673559152, 7886.6056697165195, 7886.999999999971, 7887.763367098996, 7695.461317707763, 7725.111612164561, 7754.922450775476, 7779.494332868346, 7796.844063118706, 38349.23301533954, 38398.61601383978, 38444.038899027466, 38528.0, 38660.806695966625, 3583.7312201584987, 3606.747527673064, 3620.728445366608, 3627.9818600907092, 3631.4371272452813, 30881.536776948364, 31203.0, 31226.0, 31263.0, 31296.687033129834, 4761.6904901181315, 5055.646104772667, 5065.088284108859, 5085.542301192911, 5104.0, 183707.0, 184066.0, 184580.0, 185227.0, 185254.99999999866, 47804.7609761949, 47863.76068119637, 47893.76053119712, 48243.276350854765, 48454.0, 50223.49776502188, 50429.0, 50619.74690126526, 50694.74652626787, 50948.745256274226, 13434.261115638537, 13770.24263665508, 16285.511434656979, 16593.91703041477, 16609.83390166107, 13265.734685306239, 13530.594082177551, 13581.320933953262, 13588.864111358958, 13595.796063059062, 14600.707985840436, 14649.633759156106, 14675.266236688336, 14703.926480367743, 14719.043262187923, 5810.593258471867, 5849.561282903799, 5858.443447872445, 6033.9698301508215, 6112.0, 1002.223276960347, 1004.9196064314838, 1020.7499162705185, 1021.933574317667, 1028.2236911132047, 23034.308970730905, 23055.53888922212, 23072.53854922892, 23219.95510202045, 23456.179033733737, 1101.6915263726169, 1109.1958330210532, 1109.9167562432688, 1120.0759373516719, 1136.170595465315, 12109.546854377531, 12157.69605759863, 15927.442539511061, 16284.0, 16642.08468534218, 228393.0, 231066.0, 231512.0, 231801.0, 232038.0, 57576.0, 57920.71039644775, 58230.417695823344, 58247.0, 58354.0, 1442.6802853565873, 1448.1311213272163, 1476.1143314011508, 1480.2820631993475, 1498.7826765119214, 27108.864455677594, 27122.32194195161, 27171.86414067917, 27650.446991059664, 27883.860580696968, 37680.623193767715, 37858.81070594629, 37920.81039594785, 38021.23957520889, 38032.0, 195063.0, 198113.0, 198846.0, 199148.0, 199931.0, 35538.82230588831, 38810.6118938807, 38995.220095598495, 39360.6063939357, 39541.40687889626, 46792.298115528974, 48500.51499485101, 48564.514354856, 48663.513364865896, 48707.512924870294, 34592.82703586466, 34800.0, 34905.47641785324, 34964.65035349614, 35676.64323356733, 34040.82979585086, 34175.316493670485, 34451.310973780885, 34470.0, 34885.82557087198, 38178.236435270584, 38331.0, 38337.808310958266, 38683.613163868, 38802.80598596989, 33602.49596256009, 33632.49551256684, 33803.3239335207, 33811.492827607115, 33963.320733585686, 24315.270541883772, 24493.58929517192, 24748.401417850866, 24834.50330993406, 25180.370490737878], "value": 17735.213676130956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9971800140999, 566.9461401166888, 568.9573282003851, 588.8086371929123, 610.6153123532174, 21951.67072493912, 22960.196393126243, 23066.308010759705, 23081.538369232625, 23781.76218237817, 26722.866385668043, 26891.32771680709, 27295.317617059532, 27349.863250683768, 27352.863235683843, 6526.379993900584, 6644.335566443366, 6709.731610735565, 6714.194296684404, 6717.126773519436, 5891.057430811071, 6536.8038958831075, 6555.737770489175, 6564.474842012628, 6565.113709649184, 6519.706613202417, 6527.249366322862, 6537.411632953033, 6548.312427195147, 6550.181227346582, 6532.085508028832, 6538.509611779112, 6539.50953678476, 6540.901886471706, 6543.607383556978, 6054.334023257438, 6076.635401875901, 6078.665673387962, 6084.695765211766, 6102.664353460558, 28902.0, 29515.409691806042, 29788.404231915458, 29915.850420747975, 30063.0, 1888.3107665702057, 1938.0890981238795, 1939.4957311099215, 1940.8835469871713, 1943.067327682706, 18870.15084321209, 19404.320848770225, 19499.805001950084, 19635.41093767175, 19642.214311427524, 2367.5912831865185, 2367.763223677636, 2420.4311986683115, 2428.490017096412, 2531.46839163774, 133762.0, 139276.0, 140107.5989240115, 141167.0, 141263.0, 14424.639384015483, 14769.556913292618, 14858.554243372717, 15028.549143525712, 15402.306896189475, 23233.88383058074, 23873.04507819668, 23880.044798207877, 23907.16324928619, 24035.879820600785, 10371.429571373646, 10475.319104258198, 10542.631007914839, 10698.679039628823, 10744.140468762636, 9779.853302200472, 9850.50747462624, 9923.1069203772, 10019.0, 10076.748081298027, 9433.764155896157, 9491.240700743923, 9606.742415532344, 9624.085711857362, 9696.418214907128, 2619.148776647597, 2636.7231440698833, 2655.48218097473, 2731.726827317252, 2794.4969905416815, 958.6500927161675, 968.9612415503301, 981.3130808434124, 989.8366769482955, 994.8010397920444, 19148.329808456914, 23485.882570587037, 24242.51514969691, 24322.878385607957, 24580.89385977635, 1023.8516561573192, 1053.3574519543072, 1058.0, 1061.490484567412, 1071.464267866067, 11132.332060076422, 11248.212625116163, 11309.773804524028, 11521.193516453768, 12577.371131443391, 475794.0, 481252.0, 486057.0, 493208.0, 499612.0, 110222.44888775505, 111105.44447277873, 111408.0, 118929.0, 119890.4005479967, 1241.3172754984903, 1251.355551890777, 1281.263273617655, 1283.2172374851334, 1289.1427200911476, 21244.787552124282, 21343.25298614541, 21429.678554822003, 21482.99238106635, 21548.569028619655, 55267.44732552623, 55418.0, 56234.0, 56345.0, 57600.0, 68672.6566367185, 69110.0, 69202.65398673176, 69545.30454695388, 70112.64943675249, 14168.574942751733, 14812.333444994785, 14873.553793386216, 14905.105693658415, 14914.552563423114, 23174.884125579265, 23218.88390558104, 23245.0, 23368.532629347657, 23871.641925370786, 16782.412615558398, 18246.45260642183, 18507.074646267363, 18731.0, 18906.0, 16645.750313745546, 16917.74623380675, 16926.15369231558, 16935.91532042332, 16964.915175424536, 18504.629907402046, 19458.708119378505, 19531.33983611409, 19591.80408195957, 19724.605507889475, 14782.852171478147, 14880.330385132478, 15010.399584016517, 15021.774673380127, 15036.849631503545, 18413.539661508035, 18449.446516604523, 18537.90731046336, 18587.535311617317, 18771.624567508847], "value": 12213.429198297052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.1648703073547, 1371.958841234762, 1376.6902446949434, 1381.6338670252385, 1386.4246337769819, 13590.728185436297, 13838.308084595756, 14207.786883196748, 14213.076150050252, 14258.643533911658, 14436.206008669518, 14653.706925861476, 14744.410223591043, 14748.6312842179, 14782.408703651869, 2693.2862791360303, 2759.11708253359, 2761.130243973152, 2761.3786897947903, 2761.9447611047867, 2619.1487766475875, 2621.30535408117, 2669.8264612800203, 2748.0656576763895, 2751.064638023072, 2711.6745990481168, 2712.0, 2729.9044533441333, 2743.8353698778137, 2745.1490038088155, 2570.3445621366527, 2591.2355855022815, 2592.4685439484956, 2622.278873309836, 2639.788816894644, 2515.434027343833, 2532.2403279016407, 2554.6423500709916, 2557.539642864284, 2559.910403135881, 13220.0, 13364.866351336459, 13372.799408008888, 13381.26403047832, 13395.665108372272, 7469.439792015621, 7620.580868052255, 7630.2751238632245, 7708.807279817994, 7755.185705500954, 4965.553100220961, 5176.767045482962, 5296.25852380667, 5309.946900531023, 5343.545798607123, 1768.3545505890386, 1770.1326350088493, 1817.5183576352276, 1827.826356496144, 1833.1475863723433, 23403.414914627272, 23724.76275237243, 23732.88133559321, 23748.76251237483, 23758.40603984897, 6452.5805822622315, 6462.32145624712, 6589.901151482732, 6679.933200668028, 6798.116244888231, 15797.842021579867, 15905.125218112884, 15908.602284942737, 15914.0, 15915.522534323989, 7642.312191902755, 7786.454948153575, 7798.883016754753, 7802.336801371947, 7837.725679601187, 6912.101426814583, 6939.479539034593, 7127.75052873147, 7131.786046418616, 7175.641217939082, 5030.471800460972, 5079.822206222764, 5131.794728210904, 5162.74186290684, 5187.559057480081, 1368.2884899852022, 1415.1650526189599, 1452.7675571908444, 1496.3864815425623, 1517.544736579022, 900.5092224737534, 919.6597259014208, 923.607466826596, 928.4243768863348, 929.5352323838081, 7761.844763104819, 7896.763097107096, 7961.363090952826, 7972.641231144612, 8064.596770161468, 903.3541018172039, 931.9068093190626, 974.8245315843217, 986.5757724178673, 1029.0481304793036, 5489.58828087895, 5646.774129034792, 5749.0, 5763.366029736726, 5841.620294680833, 18879.150438230314, 19591.510212244808, 19633.116509757096, 19645.901770491342, 19731.112099955535, 18835.246590136514, 19153.52116197106, 19344.32294869673, 19374.903125484565, 19404.417867464, 10116.393016419039, 10668.253222274521, 10735.248532602798, 10740.892591074145, 10807.567697292021, 7735.750984586374, 8116.594170291343, 8385.496870187808, 8482.279006284534, 8794.164554367326, 16225.0, 16917.15414229259, 16946.915265423595, 16965.04901936244, 17062.061586612854, 17093.914530427268, 17242.827571724123, 17313.56716082108, 17319.567010824325, 17365.913170434065, 12668.239905605693, 12849.743005140032, 13095.21428714242, 13096.083274170716, 13196.14225075367, 13084.80372794428, 13106.737865242832, 13249.072564920363, 13274.07081504324, 13276.668083297995, 10675.51960161779, 10827.40449275266, 10855.077318428022, 11055.115590752881, 11301.43492825339, 10076.395416275047, 10108.696739097839, 10169.644062457779, 10356.067953884187, 10558.947205263925, 9243.86134207974, 9330.673426430043, 9568.76078098053, 9698.36960597559, 9746.9025309746, 6687.264400915993, 6790.253072162157, 6812.625305608239, 6831.2144103428745, 6905.723771049102, 7083.5041547091205, 7237.312455316736, 7250.129984401906, 7262.491625586158, 7285.052943117361], "value": 6432.02249697898, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.78885262616006, 513.1584201908868, 525.0627629681019, 530.4297879779239, 535.7196300840989, 6118.4799292060225, 6169.321374648785, 6170.938290617092, 6176.907346389797, 6232.937670623298, 6159.199304090474, 6172.148355493346, 6173.814785556429, 6234.625922444645, 6238.781642642509, 5131.409887862887, 5148.176291793314, 5157.381114266274, 5158.509941555565, 5173.275741396207, 5038.6724862883975, 5070.847874563769, 5102.438731739506, 5150.407703114133, 5179.844604661847, 4712.175369310374, 4860.9756951215195, 4862.319275301443, 4937.703737775727, 4944.629152813535, 4872.342233798445, 4876.634252431064, 4884.5603895649565, 4934.235193545006, 4953.257011448276, 4369.3227549729845, 4424.823007079713, 4426.756528390937, 4430.800613972379, 4447.866564003053, 5970.0, 5981.611195272293, 6019.367966363557, 6027.819165425044, 6058.545609079337, 5598.3282006159525, 5653.321601407816, 5686.715664216814, 5692.31692196939, 5713.114467257582, 6435.259945106326, 6500.674966251669, 6519.478441724651, 6545.0, 6549.8537755893, 4824.348712923746, 4831.130396528623, 4860.989683511118, 4870.780814863339, 4873.098476781806, 6441.484681225491, 6669.266380698119, 6734.393904548614, 6831.965840170817, 6922.653867306614, 5282.3661160660195, 5368.7047212403695, 5432.674039557639, 5468.972655136698, 5492.340919089735, 5343.599230057761, 5472.124460086367, 5508.586855985817, 5531.474509921551, 5581.302337207849, 5917.704114794243, 5930.140129681172, 5934.347221805598, 5938.940610593839, 5973.37279585646, 6525.0, 6568.770093046721, 6589.835254118685, 6620.2386725527185, 6630.635315057718, 1927.1038966880467, 1960.2551030608563, 1966.3511041356603, 1970.4187264756931, 1975.664137096697, 1384.9861501384858, 1437.1951707044088, 1442.293276294629, 1453.8691517763452, 1458.3874772595536, 5672.035753921843, 5784.0, 5785.450382213683, 5798.478136967693, 5879.559033072536, 6641.169853768279, 6678.46395329077, 6686.933130668728, 6733.3266673333255, 6775.796726098225, 5724.971375143097, 5766.731319109789, 5770.538356931435, 5812.9709351452975, 5825.106840276927, 3546.262331457567, 3561.519194908706, 3579.928401431957, 3596.3346780845627, 3597.4963505109304, 6385.233771947396, 6409.327020662763, 6456.321356447357, 6465.967670161714, 6489.967550162313, 6813.148356455443, 6846.691898864563, 6847.691853866588, 6856.811582614108, 6901.723931042802, 6401.231852177769, 6437.774677886251, 6465.0, 6476.6114033158165, 6529.767764956282, 6671.966640166768, 6742.6291553965, 6745.696443659949, 6748.831279218059, 6749.527533072638, 6539.509536784855, 6573.638449885111, 6615.5038372123245, 6644.734210631521, 6652.667366631746, 6378.617282963037, 6456.741730330734, 6494.967525162533, 6506.512011599054, 6514.674266286762, 5385.515303622693, 5385.676859388449, 5399.0, 5428.4842939920645, 5451.918221226764, 6351.618902865843, 6641.601503909781, 6681.265060843206, 6732.360425759545, 6773.830654233683, 5912.70436478183, 6294.339094395023, 6402.423781859655, 6411.230652321565, 6494.383033611799, 6351.71417286214, 6373.0, 6377.93622063792, 6383.904241436289, 6474.928023032584, 6322.589031712924, 6364.713587888464, 6368.968155159195, 6386.211860679017, 6406.583572067801, 6458.806235812933, 6550.6069635822005, 6589.24223714279, 6595.307492713196, 6616.933830661632, 6309.463695585927, 6311.779087731908, 6392.68036598159, 6396.264429590657, 6415.1981002374705], "value": 5116.075391411484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.1387749801457, 829.5478963964639, 849.7153453593046, 878.446578655447, 892.6474042753113, 18048.90975545122, 18287.81712182878, 18308.90845545772, 18327.908360458212, 18419.079046047693, 16480.587985300375, 16912.746308805377, 18695.3456629018, 19154.233830646794, 22291.0, 1018.0735530667076, 1046.0689985912543, 1047.3192424923784, 1049.1292227451236, 1050.789842031593, 1052.9578816847318, 1053.2311412668757, 1053.2995557953952, 1053.9051485366315, 1058.2327812336073, 990.6285143071349, 1083.56657337065, 1092.1863211907141, 1092.7158938675962, 1108.6452335252723, 1074.9895098607324, 1076.6985244131656, 1077.849101125843, 1079.7732476179933, 1082.8105081610686, 805.4160733468248, 805.605253425823, 805.8066064144622, 806.0649646410195, 806.1938061938062, 18989.33537326201, 20666.689999650018, 20890.791092089188, 20897.164113435443, 20938.89530552353, 18751.249950001984, 19155.233790648497, 19452.319168829024, 19492.31776887802, 19629.901850490656, 16661.0, 16681.91659041709, 16747.24637391308, 16765.329386824513, 16963.91518042414, 3664.1572438339063, 3692.7230457715777, 3694.4458331250257, 3694.9815250923843, 3697.6856967157823, 117124.0, 119170.40414797957, 119821.40089299585, 123801.38099309536, 125847.3707631456, 16899.32402703878, 17776.377826776, 17792.288308467774, 17801.109944502725, 17887.910560447373, 30820.69179308223, 31400.0, 31747.0, 31779.52330715041, 31825.68174318227, 9025.0, 9032.593533291018, 9055.592498337459, 9072.092790721008, 9092.27261819053, 4217.599328063829, 4313.288307429302, 4318.114786468766, 4328.307470804656, 4332.068605249887, 4921.557059864629, 5037.0, 5066.442691303953, 5087.6947383156385, 5090.08378491875, 1057.2493529594074, 1089.700332408594, 1090.2095980414294, 1094.5074716377662, 1106.5076041161606, 568.3407247592772, 569.1519635742796, 575.0827430248746, 579.160217684351, 591.6361437715774, 10903.29128606638, 11096.500657470271, 11535.480903359368, 11608.883911160949, 11891.762164756656, 581.4272941152961, 582.0745015425409, 582.3739480058954, 586.2291087220292, 594.9524038076944, 4885.682430642068, 4919.557239848431, 4938.25926111079, 4943.802247910044, 5090.898182036339, 99627.0, 99914.0, 102582.48708756408, 106423.0, 107959.46020269848, 88991.55504222437, 93283.0, 93315.0, 95029.0, 95135.0, 69940.6502967482, 76534.61732691301, 78595.60702196452, 81830.59084704658, 84010.15989840146, 11230.775384492428, 11274.0, 11357.256468171316, 11408.087353011573, 11768.70578235551, 35427.645723543465, 35545.82227088848, 36402.27195456129, 36587.63412365949, 38496.80751596224, 45387.773061135806, 45548.26710397387, 46477.302840456745, 46869.0, 47940.520594793605, 15440.382384704486, 15444.22778861075, 15486.457973970857, 15537.378504859678, 15790.526284211492, 16259.837401625833, 16300.67398652044, 16514.504564863073, 16596.50210493687, 16638.0, 15913.443029493912, 16196.352145914032, 16199.190040498164, 16243.59391015234, 16439.589010274838, 16000.439984600484, 16174.838251617333, 16253.59366015859, 16300.67398652044, 16551.50345489589, 15853.286602102702, 16634.58413539671, 17104.401345952832, 17131.486055418358, 17207.13964301755, 11745.765084698429, 12119.272843629411, 12160.391980401122, 12442.129050966707, 12677.429515671633, 12724.91838193764, 13281.0, 13352.666183345495, 13719.657008574466, 14143.64640883986], "value": 8653.385845568175, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 103.0, 107.0, 116.0, 111.0, 107.0, 112.0, 110.0, 107.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 118.0, 152.0, 175.0, 121.0, 155.0, 151.0, 121.0, 177.0, 118.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 170.0, 163.0, 163.0, 166.0, 168.0, 166.0, 162.0, 161.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 75.0, 175.0, 76.0, 79.0, 76.0, 88.0, 101.0, 80.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 135.0, 79.0, 80.0, 85.0, 124.0, 82.0, 83.0, 132.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 114.0, 119.0, 117.0, 122.0, 115.0, 114.0, 116.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 157.0, 150.0, 150.0, 150.0, 151.0, 152.0, 151.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 97.0, 94.0, 94.0, 101.0, 94.0, 95.0, 94.0, 93.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 61.0, 62.0, 58.0, 55.0, 58.0, 56.0, 67.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 53.0, 53.0, 54.0, 54.0, 53.0, 55.0, 54.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 81.0, 89.0, 81.0, 78.0, 81.0, 89.0, 79.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 142.0, 123.0, 132.0, 125.0, 134.0, 126.0, 127.0, 180.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 175.0, 179.0, 186.0, 178.0, 177.0, 186.0, 174.0, 176.0, 174.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 73.0, 68.0, 67.0, 66.0, 67.0, 65.0, 65.0], "value": 67.3, "unit": "score"}]}]} 04:57:16 INFO - Return code: 0 04:57:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:16 INFO - # TBPL SUCCESS # 04:57:16 INFO - Running post-action listener: _package_coverage_data 04:57:16 INFO - Running post-action listener: _resource_record_post_action 04:57:16 INFO - [mozharness: 2017-08-07 11:57:16.689568Z] Finished run-tests step (success) 04:57:16 INFO - Running post-run listener: _resource_record_post_run 04:57:16 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435281920; Read time: 8; Write time: 447892 04:57:16 INFO - TinderboxPrint: CPU usage
13.2% 04:57:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:57:16 INFO - TinderboxPrint: I/O write bytes / time
435,281,920 / 447,892 04:57:16 INFO - TinderboxPrint: CPU idle
8,268.0 (86.8%) 04:57:16 INFO - TinderboxPrint: CPU user
1,206.6 (12.7%) 04:57:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:57:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112447488; Read time: 0; Write time: 123596 04:57:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:57:16 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 321712128; Read time: 0; Write time: 324264 04:57:17 INFO - Running post-run listener: _upload_blobber_files 04:57:17 INFO - Blob upload gear active. 04:57:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:17 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:57:17 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:57:17 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:57:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:57:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:57:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:18 INFO - (blobuploader) - INFO - Done attempting. 04:57:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:57:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:19 INFO - (blobuploader) - INFO - Done attempting. 04:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:26 INFO - (blobuploader) - INFO - Done attempting. 04:57:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:57:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:57:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:27 INFO - (blobuploader) - INFO - Done attempting. 04:57:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:27 INFO - Return code: 0 04:57:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27b50f57e898fddbe7ff4b3529f81a91a5cca6b75d26ef8ec759aa17f423ccc3eaa61af1056325e2e852693d5ee349c3610f0671292b4af898d1e470779fa04f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8995be8fcbbe44614b960c98e25eeca39b62b30eded741e9821f451dde53c7428425c610b61926a01b694c09b6f4ff87b5bcd5fa2b68181bc1fca8c360b3ffb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b4c46506865090107b8fbd342c0e8a800b6eee3bcdc0e7d48789ce5d5d40a9d661f2ec6e5c548b5bf152fc55419b21202e8be21ccf5e9f9e4782fd82f6e65c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45ee49e49b2997bc4f010782b13f013b194242f4c1ecd3fd219c0488a0f17982e5e188ada4c48ef53c8e560c26b5ee7dc10d5e6ba79091ec45d2a56656e0f16a"} 04:57:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:27 INFO - Contents: 04:57:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27b50f57e898fddbe7ff4b3529f81a91a5cca6b75d26ef8ec759aa17f423ccc3eaa61af1056325e2e852693d5ee349c3610f0671292b4af898d1e470779fa04f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8995be8fcbbe44614b960c98e25eeca39b62b30eded741e9821f451dde53c7428425c610b61926a01b694c09b6f4ff87b5bcd5fa2b68181bc1fca8c360b3ffb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b4c46506865090107b8fbd342c0e8a800b6eee3bcdc0e7d48789ce5d5d40a9d661f2ec6e5c548b5bf152fc55419b21202e8be21ccf5e9f9e4782fd82f6e65c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45ee49e49b2997bc4f010782b13f013b194242f4c1ecd3fd219c0488a0f17982e5e188ada4c48ef53c8e560c26b5ee7dc10d5e6ba79091ec45d2a56656e0f16a"} 04:57:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:27 INFO - Copying logs to upload dir... 04:57:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.441911 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-08-07 04:57:26.527889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 04:57:26.531831) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27b50f57e898fddbe7ff4b3529f81a91a5cca6b75d26ef8ec759aa17f423ccc3eaa61af1056325e2e852693d5ee349c3610f0671292b4af898d1e470779fa04f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8995be8fcbbe44614b960c98e25eeca39b62b30eded741e9821f451dde53c7428425c610b61926a01b694c09b6f4ff87b5bcd5fa2b68181bc1fca8c360b3ffb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b4c46506865090107b8fbd342c0e8a800b6eee3bcdc0e7d48789ce5d5d40a9d661f2ec6e5c548b5bf152fc55419b21202e8be21ccf5e9f9e4782fd82f6e65c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45ee49e49b2997bc4f010782b13f013b194242f4c1ecd3fd219c0488a0f17982e5e188ada4c48ef53c8e560c26b5ee7dc10d5e6ba79091ec45d2a56656e0f16a"} build_url:https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/S8ufqNiHTaGHbnSuZ_Q5fA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27b50f57e898fddbe7ff4b3529f81a91a5cca6b75d26ef8ec759aa17f423ccc3eaa61af1056325e2e852693d5ee349c3610f0671292b4af898d1e470779fa04f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8995be8fcbbe44614b960c98e25eeca39b62b30eded741e9821f451dde53c7428425c610b61926a01b694c09b6f4ff87b5bcd5fa2b68181bc1fca8c360b3ffb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9b4c46506865090107b8fbd342c0e8a800b6eee3bcdc0e7d48789ce5d5d40a9d661f2ec6e5c548b5bf152fc55419b21202e8be21ccf5e9f9e4782fd82f6e65c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45ee49e49b2997bc4f010782b13f013b194242f4c1ecd3fd219c0488a0f17982e5e188ada4c48ef53c8e560c26b5ee7dc10d5e6ba79091ec45d2a56656e0f16a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 04:57:26.561121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:57:26.561479) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502105764.505255-1584873218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 04:57:26.644400) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 04:57:26.645092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 04:57:26.645679) ========= ========= Total master_lag: 0.43 =========