builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1507843289.06 results: success (0) revision: 1b1762aecfb4cc27bbca9609b0acd8a372470235 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.061408) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.061957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.062252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.135036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.135287) ========= 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=923d835db2ba3686ebe126b700000192-1507837275.569208-155156370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-12 14:21:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.0M=0s 2017-10-12 14:21:29 (29.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.248119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.248394) ========= 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=923d835db2ba3686ebe126b700000192-1507837275.569208-155156370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:29.298949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-12 14:21:29.299263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1b1762aecfb4cc27bbca9609b0acd8a372470235 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1b1762aecfb4cc27bbca9609b0acd8a372470235 --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=923d835db2ba3686ebe126b700000192-1507837275.569208-155156370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-12 14:21:29,354 truncating revision to first 12 chars 2017-10-12 14:21:29,354 Setting DEBUG logging. 2017-10-12 14:21:29,354 attempt 1/10 2017-10-12 14:21:29,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1b1762aecfb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-12 14:21:30,312 unpacking tar archive at: mozilla-beta-1b1762aecfb4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-12 14:21:30.568613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:30.569005) ========= script_repo_revision: 1b1762aecfb4cc27bbca9609b0acd8a372470235 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:30.569445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:30.569741) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-12 14:21:30.587578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-12 14:21:30.587880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1507837275.569208-155156370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:21:30 INFO - MultiFileLogger online at 20171012 14:21:30 in /builds/slave/test 14:21:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 14:21:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:30 INFO - {'append_to_log': False, 14:21:30 INFO - 'base_work_dir': '/builds/slave/test', 14:21:30 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 14:21:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:30 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 14:21:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:30 INFO - 'code_coverage': False, 14:21:30 INFO - 'config_files': ('talos/linux_config.py',), 14:21:30 INFO - 'default_actions': ('clobber', 14:21:30 INFO - 'read-buildbot-config', 14:21:30 INFO - 'download-and-extract', 14:21:30 INFO - 'populate-webroot', 14:21:30 INFO - 'create-virtualenv', 14:21:30 INFO - 'install', 14:21:30 INFO - 'setup-mitmproxy', 14:21:30 INFO - 'run-tests'), 14:21:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:30 INFO - 'disable_ccov_upload': False, 14:21:30 INFO - 'disable_stylo': False, 14:21:30 INFO - 'download_minidump_stackwalk': True, 14:21:30 INFO - 'download_symbols': 'ondemand', 14:21:30 INFO - 'enable_stylo': False, 14:21:30 INFO - 'enable_webrender': False, 14:21:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:21:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:30 INFO - 'gecko_profile': False, 14:21:30 INFO - 'gecko_profile_interval': 0, 14:21:30 INFO - 'installer_path': 'installer.exe', 14:21:30 INFO - 'log_level': 'info', 14:21:30 INFO - 'log_name': 'talos', 14:21:30 INFO - 'log_to_console': True, 14:21:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:21:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:21:30 INFO - 'opt_config_files': (), 14:21:30 INFO - 'pip_index': False, 14:21:30 INFO - 'suite': 'dromaeojs-e10s', 14:21:30 INFO - 'system_bits': '32', 14:21:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:30 INFO - 'title': 'talos-linux64-ix-007', 14:21:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:30 INFO - 'use_talos_json': True, 14:21:30 INFO - 'verify': 'False', 14:21:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:30 INFO - 'work_dir': 'build'} 14:21:30 INFO - [mozharness: 2017-10-12 21:21:30.777672Z] Running clobber step. 14:21:30 INFO - Running pre-action listener: _resource_record_pre_action 14:21:30 INFO - Running main action method: clobber 14:21:30 INFO - rmtree: /builds/slave/test/build 14:21:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:31 INFO - Running post-action listener: _resource_record_post_action 14:21:31 INFO - [mozharness: 2017-10-12 21:21:31.830076Z] Finished clobber step (success) 14:21:31 INFO - [mozharness: 2017-10-12 21:21:31.830171Z] Running read-buildbot-config step. 14:21:31 INFO - Running pre-action listener: _resource_record_pre_action 14:21:31 INFO - Running main action method: read_buildbot_config 14:21:31 INFO - Using buildbot properties: 14:21:31 INFO - { 14:21:31 INFO - "project": "", 14:21:31 INFO - "product": "firefox", 14:21:31 INFO - "who": "ryanvm@gmail.com", 14:21:31 INFO - "installer_path": "public/build/target.tar.bz2", 14:21:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:21:31 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 14:21:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 14:21:31 INFO - "stage_platform": "linux64", 14:21:31 INFO - "basedir": "/builds/slave/test", 14:21:31 INFO - "buildnumber": 138, 14:21:31 INFO - "platform": "ubuntu64_hw", 14:21:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:21:31 INFO - "slavebuilddir": "test", 14:21:31 INFO - "taskId": "MO8lsLKeSnuiHfUnOVWInA", 14:21:31 INFO - "branch": "mozilla-beta", 14:21:31 INFO - "script_repo_revision": "production", 14:21:31 INFO - "revision": "1b1762aecfb4cc27bbca9609b0acd8a372470235", 14:21:31 INFO - "slavename": "talos-linux64-ix-007", 14:21:31 INFO - "repo_path": "releases/mozilla-beta" 14:21:31 INFO - } 14:21:31 INFO - Finding installer, test and symbols from parent task. 14:21:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MO8lsLKeSnuiHfUnOVWInA'}, attempt #1 14:21:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MO8lsLKeSnuiHfUnOVWInA'}, attempt #1 14:21:32 INFO - Task dependencies: BRfAEVDuTBye6F92yPuPVQ 14:21:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ'}, attempt #1 14:21:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2 14:21:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.test_packages.json 14:21:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.crashreporter-symbols.zip 14:21:33 INFO - Running post-action listener: _resource_record_post_action 14:21:33 INFO - [mozharness: 2017-10-12 21:21:33.232862Z] Finished read-buildbot-config step (success) 14:21:33 INFO - [mozharness: 2017-10-12 21:21:33.233115Z] Running download-and-extract step. 14:21:33 INFO - Running pre-action listener: _resource_record_pre_action 14:21:33 INFO - Running main action method: download_and_extract 14:21:33 INFO - mkdir: /builds/slave/test/build/tests 14:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:33 INFO - trying https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.test_packages.json 14:21:33 INFO - Downloading https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:21:33 INFO - Downloaded 989 bytes. 14:21:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:21:33 INFO - Using the following test package requirements: 14:21:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:21:33 INFO - u'common': [u'target.common.tests.zip'], 14:21:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:21:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:21:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:21:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:21:33 INFO - u'mozbase': [u'target.common.tests.zip'], 14:21:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:21:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:21:33 INFO - u'web-platform': [u'target.common.tests.zip', 14:21:33 INFO - u'target.web-platform.tests.tar.gz'], 14:21:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:21:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:21:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.common.tests.zip 14:21:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:21:33 INFO - Fetch https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.common.tests.zip into memory 14:21:35 INFO - Content-Length response header: 55184190 14:21:35 INFO - Bytes received: 55184190 14:21:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.talos.tests.zip 14:21:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:21:46 INFO - Fetch https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.talos.tests.zip into memory 14:21:48 INFO - Content-Length response header: 14509251 14:21:48 INFO - Bytes received: 14509251 14:21:48 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')]} 14:21:48 INFO - trying https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2 14:21:48 INFO - Downloading https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:21:50 INFO - Downloaded 53534943 bytes. 14:21:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2 14:21:50 INFO - mkdir: /builds/slave/test/properties 14:21:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:50 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:50 INFO - Contents: 14:21:50 INFO - build_url:https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2 14:21:50 INFO - Running post-action listener: _resource_record_post_action 14:21:50 INFO - Running post-action listener: find_tests_for_verification 14:21:50 INFO - Running post-action listener: set_extra_try_arguments 14:21:50 INFO - [mozharness: 2017-10-12 21:21:50.358631Z] Finished download-and-extract step (success) 14:21:50 INFO - [mozharness: 2017-10-12 21:21:50.358819Z] Running populate-webroot step. 14:21:50 INFO - Running pre-action listener: _resource_record_pre_action 14:21:50 INFO - Running main action method: populate_webroot 14:21:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['tresize', 14:21:50 INFO - 'tcanvasmark']}, 14:21:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['dromaeo_css', 14:21:50 INFO - 'kraken']}, 14:21:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'tests': ['damp', 'tps']}, 14:21:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['damp', 'tps']}, 14:21:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['dromaeo_dom']}, 14:21:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:21:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['basic_compositor_video', 14:21:50 INFO - 'glvideo']}, 14:21:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:21:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['ts_paint_webext', 14:21:50 INFO - 'tp5o_webext']}, 14:21:50 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:50 INFO - 'ts_paint', 14:21:50 INFO - 'tpaint', 14:21:50 INFO - 'sessionrestore', 14:21:50 INFO - 'sessionrestore_many_windows', 14:21:50 INFO - 'sessionrestore_no_auto_restore', 14:21:50 INFO - 'tabpaint']}, 14:21:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['a11yr', 14:21:50 INFO - 'ts_paint', 14:21:50 INFO - 'tpaint', 14:21:50 INFO - 'sessionrestore', 14:21:50 INFO - 'sessionrestore_many_windows', 14:21:50 INFO - 'sessionrestore_no_auto_restore', 14:21:50 INFO - 'tabpaint']}, 14:21:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:21:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 14:21:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['perf_reftest_singletons']}, 14:21:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['bloom_basic']}, 14:21:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:50 INFO - 'tsvgr_opacity', 14:21:50 INFO - 'tart', 14:21:50 INFO - 'tscrollx', 14:21:50 INFO - 'tsvg_static']}, 14:21:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['tsvgx', 14:21:50 INFO - 'tsvgr_opacity', 14:21:50 INFO - 'tart', 14:21:50 INFO - 'tscrollx', 14:21:50 INFO - 'tsvg_static']}, 14:21:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:21:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'talos_options': ['--disable-stylo'], 14:21:50 INFO - 'tests': ['tp5o']}, 14:21:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:50 INFO - 'talos_options': ['--mitmproxy', 14:21:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:50 INFO - '--firstNonBlankPaint'], 14:21:50 INFO - 'tests': ['tp6_google', 14:21:50 INFO - 'tp6_youtube', 14:21:50 INFO - 'tp6_amazon', 14:21:50 INFO - 'tp6_facebook']}, 14:21:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:50 INFO - 'talos_options': ['--disable-stylo', 14:21:50 INFO - '--mitmproxy', 14:21:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:50 INFO - '--firstNonBlankPaint'], 14:21:50 INFO - 'tests': ['tp6_google', 14:21:50 INFO - 'tp6_youtube', 14:21:50 INFO - 'tp6_amazon', 14:21:50 INFO - 'tp6_facebook']}, 14:21:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:21:50 INFO - 'talos_options': ['--stylo-threads=1', 14:21:50 INFO - '--mitmproxy', 14:21:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:21:50 INFO - '--firstNonBlankPaint'], 14:21:50 INFO - 'tests': ['tp6_google', 14:21:50 INFO - 'tp6_youtube', 14:21:50 INFO - 'tp6_amazon', 14:21:50 INFO - 'tp6_facebook']}, 14:21:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'talos_options': ['--xperf_path', 14:21:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:50 INFO - 'tests': ['tp5n']}, 14:21:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:21:50 INFO - 'talos_options': ['--disable-stylo', 14:21:50 INFO - '--xperf_path', 14:21:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:50 INFO - 'tests': ['tp5n']}}} 14:21:50 INFO - Running post-action listener: _resource_record_post_action 14:21:50 INFO - [mozharness: 2017-10-12 21:21:50.379288Z] Finished populate-webroot step (success) 14:21:50 INFO - [mozharness: 2017-10-12 21:21:50.379377Z] Running create-virtualenv step. 14:21:50 INFO - Running pre-action listener: _resource_record_pre_action 14:21:50 INFO - Running main action method: create_virtualenv 14:21:50 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:21:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:21:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:21:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:51 INFO - Installing pip...............done. 14:21:51 INFO - Return code: 0 14:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:21:51 INFO - Reading from file tmpfile_stdout 14:21:51 INFO - Output received: 14:21:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:21:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:51 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')]} 14:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:51 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')]} 14:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:51 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:21:51 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 14:21:51 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 14:21:51 INFO - Using env: {'DISPLAY': ':0', 14:21:51 INFO - 'HOME': '/home/cltbld', 14:21:51 INFO - 'LANG': 'en_US.UTF-8', 14:21:51 INFO - 'LANGUAGE': 'en_US:en', 14:21:51 INFO - 'LOGNAME': 'cltbld', 14:21:51 INFO - 'MAIL': '/var/mail/cltbld', 14:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:51 INFO - 'MOZ_NO_REMOTE': '1', 14:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:51 INFO - 'NO_EM_RESTART': '1', 14:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:51 INFO - 'PWD': '/builds/slave/test', 14:21:51 INFO - 'SHELL': '/bin/bash', 14:21:51 INFO - 'SHLVL': '1', 14:21:51 INFO - 'TERM': 'linux', 14:21:51 INFO - 'TMOUT': '86400', 14:21:51 INFO - 'USER': 'cltbld', 14:21:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:51 INFO - '_': '/tools/buildbot/bin/python'} 14:21:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:21:52 INFO - Downloading/unpacking pip>=1.5 14:21:52 INFO - Running setup.py egg_info for package pip 14:21:52 INFO - warning: no files found matching 'pip/cacert.pem' 14:21:52 INFO - warning: no files found matching '*.html' under directory 'docs' 14:21:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:21:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:21:52 INFO - Installing collected packages: pip 14:21:52 INFO - Found existing installation: pip 1.1 14:21:52 INFO - Uninstalling pip: 14:21:52 INFO - Successfully uninstalled pip 14:21:52 INFO - Running setup.py install for pip 14:21:52 INFO - warning: no files found matching 'pip/cacert.pem' 14:21:52 INFO - warning: no files found matching '*.html' under directory 'docs' 14:21:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:21:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:21:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:21:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:21:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:21:52 INFO - Successfully installed pip 14:21:52 INFO - Cleaning up... 14:21:52 INFO - Return code: 0 14:21:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:52 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:21:52 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 14:21:52 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 14:21:52 INFO - Using env: {'DISPLAY': ':0', 14:21:52 INFO - 'HOME': '/home/cltbld', 14:21:52 INFO - 'LANG': 'en_US.UTF-8', 14:21:52 INFO - 'LANGUAGE': 'en_US:en', 14:21:52 INFO - 'LOGNAME': 'cltbld', 14:21:52 INFO - 'MAIL': '/var/mail/cltbld', 14:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:52 INFO - 'MOZ_NO_REMOTE': '1', 14:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:52 INFO - 'NO_EM_RESTART': '1', 14:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:52 INFO - 'PWD': '/builds/slave/test', 14:21:52 INFO - 'SHELL': '/bin/bash', 14:21:52 INFO - 'SHLVL': '1', 14:21:52 INFO - 'TERM': 'linux', 14:21:52 INFO - 'TMOUT': '86400', 14:21:52 INFO - 'USER': 'cltbld', 14:21:52 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:52 INFO - '_': '/tools/buildbot/bin/python'} 14:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:53 INFO - Downloading/unpacking psutil>=3.1.1 14:21:53 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 14:21:53 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 14:21:53 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 14:21:53 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 14:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:54 INFO - Installing collected packages: psutil 14:21:54 INFO - Running setup.py install for psutil 14:21:54 INFO - building 'psutil._psutil_linux' extension 14:21:54 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 14:21:54 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 14:21:54 INFO - building 'psutil._psutil_posix' extension 14:21:54 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 14:21:54 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 14:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:54 INFO - Successfully installed psutil 14:21:54 INFO - Cleaning up... 14:21:54 INFO - Return code: 0 14:21:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:21:54 INFO - Using env: {'DISPLAY': ':0', 14:21:54 INFO - 'HOME': '/home/cltbld', 14:21:54 INFO - 'LANG': 'en_US.UTF-8', 14:21:54 INFO - 'LANGUAGE': 'en_US:en', 14:21:54 INFO - 'LOGNAME': 'cltbld', 14:21:54 INFO - 'MAIL': '/var/mail/cltbld', 14:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:54 INFO - 'MOZ_NO_REMOTE': '1', 14:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:54 INFO - 'NO_EM_RESTART': '1', 14:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:54 INFO - 'PWD': '/builds/slave/test', 14:21:54 INFO - 'SHELL': '/bin/bash', 14:21:54 INFO - 'SHLVL': '1', 14:21:54 INFO - 'TERM': 'linux', 14:21:54 INFO - 'TMOUT': '86400', 14:21:54 INFO - 'USER': 'cltbld', 14:21:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:54 INFO - '_': '/tools/buildbot/bin/python'} 14:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:21:55 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 14:21:55 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 14:21:55 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 14:21:55 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 14:21:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:21:56 INFO - Installing collected packages: mozsystemmonitor 14:21:56 INFO - Running setup.py install for mozsystemmonitor 14:21:56 INFO - Successfully installed mozsystemmonitor 14:21:56 INFO - Cleaning up... 14:21:57 INFO - Return code: 0 14:21:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21: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')]} 14:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:57 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:21:57 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 14:21:57 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 14:21:57 INFO - Using env: {'DISPLAY': ':0', 14:21:57 INFO - 'HOME': '/home/cltbld', 14:21:57 INFO - 'LANG': 'en_US.UTF-8', 14:21:57 INFO - 'LANGUAGE': 'en_US:en', 14:21:57 INFO - 'LOGNAME': 'cltbld', 14:21:57 INFO - 'MAIL': '/var/mail/cltbld', 14:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:57 INFO - 'MOZ_NO_REMOTE': '1', 14:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:57 INFO - 'NO_EM_RESTART': '1', 14:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:57 INFO - 'PWD': '/builds/slave/test', 14:21:57 INFO - 'SHELL': '/bin/bash', 14:21:57 INFO - 'SHLVL': '1', 14:21:57 INFO - 'TERM': 'linux', 14:21:57 INFO - 'TMOUT': '86400', 14:21:57 INFO - 'USER': 'cltbld', 14:21:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:57 INFO - '_': '/tools/buildbot/bin/python'} 14:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:57 INFO - Downloading/unpacking jsonschema==2.5.1 14:21:57 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 14:21:57 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 14:21:57 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 14:21:57 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 14:21:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:59 INFO - warning: no files found matching '*.txt' 14:21:59 INFO - no previously-included directories found matching 'build' 14:21:59 INFO - no previously-included directories found matching 'dist' 14:21:59 INFO - no previously-included directories found matching '.git*' 14:21:59 INFO - Installing collected packages: jsonschema, functools32 14:21:59 INFO - Running setup.py install for functools32 14:21:59 INFO - warning: no files found matching '*.txt' 14:21:59 INFO - no previously-included directories found matching 'build' 14:21:59 INFO - no previously-included directories found matching 'dist' 14:21:59 INFO - no previously-included directories found matching '.git*' 14:21:59 INFO - Successfully installed jsonschema functools32 14:21:59 INFO - Cleaning up... 14:21:59 INFO - Return code: 0 14:21:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:21:59 INFO - Using env: {'DISPLAY': ':0', 14:21:59 INFO - 'HOME': '/home/cltbld', 14:21:59 INFO - 'LANG': 'en_US.UTF-8', 14:21:59 INFO - 'LANGUAGE': 'en_US:en', 14:21:59 INFO - 'LOGNAME': 'cltbld', 14:21:59 INFO - 'MAIL': '/var/mail/cltbld', 14:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:59 INFO - 'MOZ_NO_REMOTE': '1', 14:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:59 INFO - 'NO_EM_RESTART': '1', 14:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:59 INFO - 'PWD': '/builds/slave/test', 14:21:59 INFO - 'SHELL': '/bin/bash', 14:21:59 INFO - 'SHLVL': '1', 14:21:59 INFO - 'TERM': 'linux', 14:21:59 INFO - 'TMOUT': '86400', 14:21:59 INFO - 'USER': 'cltbld', 14:21:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:59 INFO - '_': '/tools/buildbot/bin/python'} 14:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:21:59 INFO - Cleaning up... 14:21:59 INFO - Return code: 0 14:21:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:21:59 INFO - Using env: {'DISPLAY': ':0', 14:21:59 INFO - 'HOME': '/home/cltbld', 14:21:59 INFO - 'LANG': 'en_US.UTF-8', 14:21:59 INFO - 'LANGUAGE': 'en_US:en', 14:21:59 INFO - 'LOGNAME': 'cltbld', 14:21:59 INFO - 'MAIL': '/var/mail/cltbld', 14:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:59 INFO - 'MOZ_NO_REMOTE': '1', 14:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:21:59 INFO - 'NO_EM_RESTART': '1', 14:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:59 INFO - 'PWD': '/builds/slave/test', 14:21:59 INFO - 'SHELL': '/bin/bash', 14:21:59 INFO - 'SHLVL': '1', 14:21:59 INFO - 'TERM': 'linux', 14:21:59 INFO - 'TMOUT': '86400', 14:21:59 INFO - 'USER': 'cltbld', 14:21:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:59 INFO - '_': '/tools/buildbot/bin/python'} 14:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:59 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:01 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22: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 14:22: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 14:22: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 14:22: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 14:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22: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 14:22: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 14:22: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 14:22: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 14:22:01 INFO - Downloading docopt-0.6.1.tar.gz 14:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:01 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:01 INFO - Running setup.py install for blobuploader 14:22:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:01 INFO - Running setup.py install for requests 14:22:02 INFO - Running setup.py install for docopt 14:22:02 INFO - Successfully installed blobuploader requests docopt 14:22:02 INFO - Cleaning up... 14:22:02 INFO - Return code: 0 14:22:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:02 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:22:02 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 14:22:02 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 14:22:02 INFO - Using env: {'DISPLAY': ':0', 14:22:02 INFO - 'HOME': '/home/cltbld', 14:22:02 INFO - 'LANG': 'en_US.UTF-8', 14:22:02 INFO - 'LANGUAGE': 'en_US:en', 14:22:02 INFO - 'LOGNAME': 'cltbld', 14:22:02 INFO - 'MAIL': '/var/mail/cltbld', 14:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:02 INFO - 'MOZ_NO_REMOTE': '1', 14:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:02 INFO - 'NO_EM_RESTART': '1', 14:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:02 INFO - 'PWD': '/builds/slave/test', 14:22:02 INFO - 'SHELL': '/bin/bash', 14:22:02 INFO - 'SHLVL': '1', 14:22:02 INFO - 'TERM': 'linux', 14:22:02 INFO - 'TMOUT': '86400', 14:22:02 INFO - 'USER': 'cltbld', 14:22:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:02 INFO - '_': '/tools/buildbot/bin/python'} 14:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:02 INFO - Running setup.py (path:/tmp/pip-oRUYfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:02 INFO - Running setup.py (path:/tmp/pip-a58q40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:02 INFO - Running setup.py (path:/tmp/pip-Gr3WBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:02 INFO - Running setup.py (path:/tmp/pip-mvNfZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:02 INFO - Running setup.py (path:/tmp/pip-ETB9F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:02 INFO - Running setup.py (path:/tmp/pip-1kEUgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:02 INFO - Running setup.py (path:/tmp/pip-bLfn4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:03 INFO - Running setup.py (path:/tmp/pip-tNIpOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:03 INFO - Running setup.py (path:/tmp/pip-w_f6RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:03 INFO - Running setup.py (path:/tmp/pip-ZSh9F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:03 INFO - Running setup.py (path:/tmp/pip-FlVkvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:03 INFO - Running setup.py (path:/tmp/pip-dc0tFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:03 INFO - Running setup.py (path:/tmp/pip-FiVVX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:03 INFO - Running setup.py (path:/tmp/pip-XWrTqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:03 INFO - Running setup.py (path:/tmp/pip-FBke0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:03 INFO - Running setup.py (path:/tmp/pip-h2a5be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:03 INFO - Running setup.py (path:/tmp/pip-1DFxto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:03 INFO - Running setup.py install for manifestparser 14:22:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:03 INFO - Running setup.py install for mozcrash 14:22:03 INFO - Running setup.py install for mozdebug 14:22:04 INFO - Running setup.py install for mozdevice 14:22:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozfile 14:22:04 INFO - Running setup.py install for mozhttpd 14:22:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozinfo 14:22:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozInstall 14:22:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozleak 14:22:04 INFO - Running setup.py install for mozlog 14:22:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for moznetwork 14:22:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:04 INFO - Running setup.py install for mozprocess 14:22:04 INFO - Running setup.py install for mozprofile 14:22:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Running setup.py install for mozrunner 14:22:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Running setup.py install for mozscreenshot 14:22:05 INFO - Running setup.py install for moztest 14:22:05 INFO - Running setup.py install for mozversion 14:22:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:05 INFO - Cleaning up... 14:22:05 INFO - Return code: 0 14:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:05 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')]} 14:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:05 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')]} 14:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:05 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:22:05 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 14:22:05 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 14:22:05 INFO - Using env: {'DISPLAY': ':0', 14:22:05 INFO - 'HOME': '/home/cltbld', 14:22:05 INFO - 'LANG': 'en_US.UTF-8', 14:22:05 INFO - 'LANGUAGE': 'en_US:en', 14:22:05 INFO - 'LOGNAME': 'cltbld', 14:22:05 INFO - 'MAIL': '/var/mail/cltbld', 14:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:05 INFO - 'MOZ_NO_REMOTE': '1', 14:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:05 INFO - 'NO_EM_RESTART': '1', 14:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:05 INFO - 'PWD': '/builds/slave/test', 14:22:05 INFO - 'SHELL': '/bin/bash', 14:22:05 INFO - 'SHLVL': '1', 14:22:05 INFO - 'TERM': 'linux', 14:22:05 INFO - 'TMOUT': '86400', 14:22:05 INFO - 'USER': 'cltbld', 14:22:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:05 INFO - '_': '/tools/buildbot/bin/python'} 14:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:05 INFO - Running setup.py (path:/tmp/pip-clC2pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:05 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)) 14:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:05 INFO - Running setup.py (path:/tmp/pip-es0UMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:05 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)) 14:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:05 INFO - Running setup.py (path:/tmp/pip-KvrQ8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:05 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)) 14:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:05 INFO - Running setup.py (path:/tmp/pip-12ewbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:06 INFO - Running setup.py (path:/tmp/pip-NyxjJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:06 INFO - Running setup.py (path:/tmp/pip-Av_r_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:06 INFO - Running setup.py (path:/tmp/pip-DWEAdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:06 INFO - Running setup.py (path:/tmp/pip-BrEhR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:06 INFO - Running setup.py (path:/tmp/pip-xMmQ5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:06 INFO - Running setup.py (path:/tmp/pip-DypCsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:06 INFO - Running setup.py (path:/tmp/pip-CZ2kh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:06 INFO - Running setup.py (path:/tmp/pip-T9ARTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:06 INFO - Running setup.py (path:/tmp/pip-eVScVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:06 INFO - Running setup.py (path:/tmp/pip-jbQs6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:06 INFO - Running setup.py (path:/tmp/pip-mKQ0dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:06 INFO - Running setup.py (path:/tmp/pip-xH0DPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:06 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)) 14:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:06 INFO - Running setup.py (path:/tmp/pip-gTyYtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:06 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)) 14:22:06 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)) 14:22:06 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)) 14:22:06 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)) 14:22:06 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)) 14:22:06 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)) 14:22:06 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)) 14:22:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22: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 14:22: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 14:22: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 14:22: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 14:22:08 INFO - Downloading blessings-1.6.tar.gz 14:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:08 INFO - Installing collected packages: blessings 14:22:08 INFO - Running setup.py install for blessings 14:22:08 INFO - Successfully installed blessings 14:22:08 INFO - Cleaning up... 14:22:08 INFO - Return code: 0 14:22:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:08 INFO - Reading from file tmpfile_stdout 14:22:08 INFO - Current package versions: 14:22:08 INFO - argparse == 1.2.1 14:22:08 INFO - blessings == 1.6 14:22:08 INFO - blobuploader == 1.2.4 14:22:08 INFO - docopt == 0.6.1 14:22:08 INFO - functools32 == 3.2.3-2 14:22:08 INFO - jsonschema == 2.5.1 14:22:08 INFO - manifestparser == 1.1 14:22:08 INFO - mozInstall == 1.13 14:22:08 INFO - mozcrash == 1.0 14:22:08 INFO - mozdebug == 0.1 14:22:08 INFO - mozdevice == 0.51 14:22:08 INFO - mozfile == 1.2 14:22:08 INFO - mozhttpd == 0.7 14:22:08 INFO - mozinfo == 0.10 14:22:08 INFO - mozleak == 0.1 14:22:08 INFO - mozlog == 3.5 14:22:08 INFO - moznetwork == 0.27 14:22:08 INFO - mozprocess == 0.25 14:22:08 INFO - mozprofile == 0.28 14:22:08 INFO - mozrunner == 6.13 14:22:08 INFO - mozscreenshot == 0.1 14:22:08 INFO - mozsystemmonitor == 0.3 14:22:08 INFO - moztest == 0.8 14:22:08 INFO - mozversion == 1.4 14:22:08 INFO - psutil == 3.1.1 14:22:08 INFO - requests == 1.2.3 14:22:08 INFO - wsgiref == 0.1.2 14:22:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22: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')]} 14:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:08 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:22:08 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 14:22:08 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 14:22:08 INFO - Using env: {'DISPLAY': ':0', 14:22:08 INFO - 'HOME': '/home/cltbld', 14:22:08 INFO - 'LANG': 'en_US.UTF-8', 14:22:08 INFO - 'LANGUAGE': 'en_US:en', 14:22:08 INFO - 'LOGNAME': 'cltbld', 14:22:08 INFO - 'MAIL': '/var/mail/cltbld', 14:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:08 INFO - 'MOZ_NO_REMOTE': '1', 14:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:08 INFO - 'NO_EM_RESTART': '1', 14:22:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:08 INFO - 'PWD': '/builds/slave/test', 14:22:08 INFO - 'SHELL': '/bin/bash', 14:22:08 INFO - 'SHLVL': '1', 14:22:08 INFO - 'TERM': 'linux', 14:22:08 INFO - 'TMOUT': '86400', 14:22:08 INFO - 'USER': 'cltbld', 14:22:08 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:08 INFO - '_': '/tools/buildbot/bin/python'} 14:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 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)) 14:22:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:22: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 14:22: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 14:22: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 14:22: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 14:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:22:09 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)) 14:22:09 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)) 14:22:09 INFO - Installing collected packages: simplejson 14:22:09 INFO - Running setup.py install for simplejson 14:22:10 INFO - building 'simplejson._speedups' extension 14:22:10 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 14:22:10 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 14:22:10 INFO - Successfully installed simplejson 14:22:10 INFO - Cleaning up... 14:22:10 INFO - Return code: 0 14:22:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:10 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')]} 14:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:10 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')]} 14:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:10 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 0x1eae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2076a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2219a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, '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': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', '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 14:22:10 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 14:22:10 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 14:22:10 INFO - Using env: {'DISPLAY': ':0', 14:22:10 INFO - 'HOME': '/home/cltbld', 14:22:10 INFO - 'LANG': 'en_US.UTF-8', 14:22:10 INFO - 'LANGUAGE': 'en_US:en', 14:22:10 INFO - 'LOGNAME': 'cltbld', 14:22:10 INFO - 'MAIL': '/var/mail/cltbld', 14:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:10 INFO - 'MOZ_NO_REMOTE': '1', 14:22:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:10 INFO - 'NO_EM_RESTART': '1', 14:22:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:10 INFO - 'PWD': '/builds/slave/test', 14:22:10 INFO - 'SHELL': '/bin/bash', 14:22:10 INFO - 'SHLVL': '1', 14:22:10 INFO - 'TERM': 'linux', 14:22:10 INFO - 'TMOUT': '86400', 14:22:10 INFO - 'USER': 'cltbld', 14:22:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:10 INFO - '_': '/tools/buildbot/bin/python'} 14:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:22:11 INFO - Cleaning up... 14:22:11 INFO - Return code: 0 14:22:11 INFO - Running post-action listener: _resource_record_post_action 14:22:11 INFO - Running post-action listener: _start_resource_monitoring 14:22:11 INFO - Starting resource monitoring. 14:22:11 INFO - [mozharness: 2017-10-12 21:22:11.229708Z] Finished create-virtualenv step (success) 14:22:11 INFO - [mozharness: 2017-10-12 21:22:11.230217Z] Running install step. 14:22:11 INFO - Running pre-action listener: _resource_record_pre_action 14:22:11 INFO - Running main action method: install 14:22:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:11 INFO - Reading from file tmpfile_stdout 14:22:11 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:11 INFO - Reading from file tmpfile_stdout 14:22:11 INFO - Output received: 14:22:11 INFO - Usage: mozinstall [options] installer 14:22:11 INFO - Options: 14:22:11 INFO - -h, --help show this help message and exit 14:22:11 INFO - -d DEST, --destination=DEST 14:22:11 INFO - Directory to install application into. [default: 14:22:11 INFO - "/builds/slave/test"] 14:22:11 INFO - --app=APP Application being installed. [default: firefox] 14:22:11 INFO - mkdir: /builds/slave/test/build/application 14:22:11 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'] 14:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:22:26 INFO - Reading from file tmpfile_stdout 14:22:26 INFO - Output received: 14:22:26 INFO - /builds/slave/test/build/application/firefox/firefox 14:22:26 INFO - Running post-action listener: _resource_record_post_action 14:22:26 INFO - [mozharness: 2017-10-12 21:22:26.170679Z] Finished install step (success) 14:22:26 INFO - [mozharness: 2017-10-12 21:22:26.170824Z] Running setup-mitmproxy step. 14:22:26 INFO - Running pre-action listener: _resource_record_pre_action 14:22:26 INFO - Running main action method: setup_mitmproxy 14:22:26 INFO - Skipping: mitmproxy is not required 14:22:26 INFO - Running post-action listener: _resource_record_post_action 14:22:26 INFO - [mozharness: 2017-10-12 21:22:26.171348Z] Finished setup-mitmproxy step (success) 14:22:26 INFO - [mozharness: 2017-10-12 21:22:26.171447Z] Running run-tests step. 14:22:26 INFO - Running pre-action listener: _resource_record_pre_action 14:22:26 INFO - Running pre-action listener: _set_gcov_prefix 14:22:26 INFO - Running main action method: run_tests 14:22:26 WARNING - Try message not found. 14:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:26 INFO - Python 2.7.3 14:22:26 INFO - Return code: 0 14:22:26 INFO - grabbing minidump binary from tooltool 14:22:26 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')]} 14:22:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x221d090>, '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 0x221dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2217f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 14:22:26 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:22:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 14:22:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:26 INFO - Return code: 0 14:22:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:22:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:26 INFO - ENV: RUST_BACKTRACE is now full 14:22:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:22:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 14:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 14:22:26 INFO - Using env: {'DISPLAY': ':0', 14:22:26 INFO - 'HOME': '/home/cltbld', 14:22:26 INFO - 'LANG': 'en_US.UTF-8', 14:22:26 INFO - 'LANGUAGE': 'en_US:en', 14:22:26 INFO - 'LOGNAME': 'cltbld', 14:22:26 INFO - 'MAIL': '/var/mail/cltbld', 14:22:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:26 INFO - 'MOZ_NO_REMOTE': '1', 14:22:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:26 INFO - 'NO_EM_RESTART': '1', 14:22:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:26 INFO - 'PWD': '/builds/slave/test', 14:22:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:26 INFO - 'RUST_BACKTRACE': 'full', 14:22:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:22:26 INFO - 'SHELL': '/bin/bash', 14:22:26 INFO - 'SHLVL': '1', 14:22:26 INFO - 'TERM': 'linux', 14:22:26 INFO - 'TMOUT': '86400', 14:22:26 INFO - 'USER': 'cltbld', 14:22:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:26 INFO - '_': '/tools/buildbot/bin/python'} 14:22:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 14:22:26 INFO - mozversion application_buildid: 20171012200843 14:22:26 INFO - mozversion application_changeset: 1b1762aecfb4cc27bbca9609b0acd8a372470235 14:22:26 INFO - mozversion application_display_name: Firefox 14:22:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:26 INFO - mozversion application_name: Firefox 14:22:26 INFO - mozversion application_remotingname: firefox 14:22:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:26 INFO - mozversion application_vendor: Mozilla 14:22:26 INFO - mozversion application_version: 57.0 14:22:26 INFO - mozversion platform_buildid: 20171012200843 14:22:26 INFO - mozversion platform_changeset: 1b1762aecfb4cc27bbca9609b0acd8a372470235 14:22:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:22:26 INFO - mozversion platform_version: 57.0 14:22:26 INFO - using testdate: 1507843346 14:22:26 INFO - actual date: 1507843346 14:22:26 INFO - starting webserver on 'localhost:55708' 14:22:26 INFO - SUITE-START | Running 2 tests 14:22:26 INFO - TEST-START | dromaeo_css 14:22:26 INFO - Initialising browser for dromaeo_css test... 14:22:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html -profile /tmp/tmpuvcnML/profile 14:22:26 INFO - TEST-INFO | started process 26349 (/builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html) 14:22:30 INFO - TEST-INFO | 26349: exit 0 14:22:30 INFO - Browser initialized. 14:22:30 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:30 INFO - Using env: {'DISPLAY': ':0', 14:22:30 INFO - 'HOME': '/home/cltbld', 14:22:30 INFO - 'JSGC_DISABLE_POISONING': '1', 14:22:30 INFO - 'LANG': 'en_US.UTF-8', 14:22:30 INFO - 'LANGUAGE': 'en_US:en', 14:22:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:22:30 INFO - 'LOGNAME': 'cltbld', 14:22:30 INFO - 'MAIL': '/var/mail/cltbld', 14:22:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:22:30 INFO - 'MOZ_CRASHREPORTER': '1', 14:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:22:30 INFO - 'MOZ_NO_REMOTE': '1', 14:22:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:22:30 INFO - 'NO_EM_RESTART': '1', 14:22:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:30 INFO - 'PWD': '/builds/slave/test', 14:22:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:30 INFO - 'RUST_BACKTRACE': 'full', 14:22:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:22:30 INFO - 'SHELL': '/bin/bash', 14:22:30 INFO - 'SHLVL': '1', 14:22:30 INFO - 'TERM': 'linux', 14:22:30 INFO - 'TMOUT': '86400', 14:22:30 INFO - 'USER': 'cltbld', 14:22:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:30 INFO - '_': '/tools/buildbot/bin/python'} 14:22:30 INFO - TEST-INFO | started process 26583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuvcnML/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:31 INFO - PID 26583 | 14:22:31 INFO - PID 26583 | (/builds/slave/test/build/application/firefox/firefox:26631): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:22:31 INFO - PID 26583 | 14:22:42 INFO - PID 26583 | RSS: Main: 143577088 14:22:42 INFO - PID 26583 | 14:25:38 INFO - PID 26583 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55708/tests/dromaeo/cssquery-ext.html) 14:25:40 INFO - PID 26583 | RSS: Main: 145813504 14:25:40 INFO - PID 26583 | 14:28:41 INFO - PID 26583 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-ext.html (next: http://localhost:55708/tests/dromaeo/cssquery-jquery.html) 14:28:42 INFO - PID 26583 | RSS: Main: 144723968 14:28:42 INFO - PID 26583 | 14:31:43 INFO - PID 26583 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55708/tests/dromaeo/cssquery-mootools.html) 14:31:44 INFO - PID 26583 | RSS: Main: 144363520 14:31:44 INFO - PID 26583 | 14:34:46 INFO - PID 26583 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55708/tests/dromaeo/cssquery-prototype.html) 14:34:46 INFO - PID 26583 | RSS: Main: 145768448 14:34:46 INFO - PID 26583 | 14:37:49 INFO - PID 26583 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55708/tests/dromaeo/cssquery-yui.html) 14:37:50 INFO - PID 26583 | RSS: Main: 146878464 14:37:50 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | Cycle 1(1): loaded http://localhost:55708/tests/dromaeo/cssquery-yui.html (next: http://localhost:55708/tests/dromaeo/cssquery-dojo.html) 14:40:51 INFO - PID 26583 | RSS: Main: 150097920 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | __start_tp_report 14:40:51 INFO - PID 26583 | _x_x_mozilla_page_load 14:40:51 INFO - PID 26583 | _x_x_mozilla_page_load_details 14:40:51 INFO - PID 26583 | |i|pagename|runs| 14:40:51 INFO - PID 26583 | |0;dojo.html;3912.8434862605486;3931.233409485151;3988.361862102064;3997.160596274782;4015.6787457003443;6333.176687030686;6342.841428964267;6357.8092657220295;6434.292227854938;6434.903476447857;6374.139491168691;6400.679966001693;6453.451456626192;6462.741490340381;6472.029195620659;5709.314882214119;5732.455416735414;5800.15897694834;5827.475527202551;5862.794802181925;5779.479846813786;5804.535637149018;5870.442307980735;5873.119032145191;5926.585139040269;5943.702814859262;5988.940110598904;5991.490723288504;5994.820155395345;5997.550183736215;5872.207252020987;5886.558508111866;5908.379620139866;5949.9702501487645;5972.134040564116;5758.856028599319;5765.106408506688;5768.221290125864;5826.213461182729;5859.384764599741;6407.135036770023;6415.743370265184;6435.613863168225;6448.93551064488;6450.225972883284;6955.269696681877;6975.651217439107;6988.54574452664;7045.471589630798;7069.540479868792;6965.860682786367;6986.650667466606;7038.15542134942;7060.3292687194635;7088.503804733671;6339.683015849189;6406.103145559626;6409.359064093554;6477.611343319416;6532.8366790830605;7080.504364694525;7086.2205157432645;7091.751788687371;7178.964105179545;7211.062561866924;6810.965945170243;6826.385625293748;6888.380045795902;6896.103506544117;6897.896336586122;6939.063226464464;6954.026436298922;6980.685869135901;7008.719651213894;7018.192907815666;6914.101166848278;6997.1253593300835;7007.334303241184;7008.684609192598;7011.439084873198;6854;6913.965430172817;6923.342282483156;7020.297970203041;7030.929690703129;5080.669756465818;5082.567981721521;5083.364579427572;5110.233464980282;5131.923021154686;4710.882227944328;4779.569838714463;4801.159797035505;4844.2007068833245;4857;6390.041493775971;6513.869722605521;6527.934720652827;6608.074869518271;6610.140681711347;6921.688524016431;6925.965370173117;6941.930580694229;6950;6990.335918087875;6405.231372235268;6436.967815160988;6504.38208370204;6522.282548919615;6539.215294164635;5836.503897168788;5865.3254875689845;5925.525957923356;5928.614640048383;5942.762289508371;7206.531575447579;7224.4942854000765;7302.2697730226555;7399.4450416219;7404.666789994463;6806.7957961261245;6844.939034449668;6851.520393572402;6941.201761797458;7044.436445084483;7197.244289349543;7238.493305468567;7250.60121693312;7257.782266532013;7345.853082938204;6777.322267773183;6797.218319893275;6852.760153394607;6865.691043902936;6915.827104322432;6938.23679395256;6979.965100174467;7006.159260888726;7017.824554385977;7023.367896889305;6704.363085506869;6747.932520674927;6751.729930802713;6755.121834161528;6764.932350676627;6684.532082754161;6714.160729908762;6754.527183097136;6759.594424334556;6768.898466522907;6617.867642647217;6625.271220165681;6632.668366581555;6714.3957043866285;6725.092112564741;6593.901091483535;6738.090357801634;6779.661016949231;6823.488238382042;6832.487563432663;6584.045313429621;6588.781075501048;6646.83382915431;6662.533622646368;6665.733370665119 14:40:51 INFO - PID 26583 | |1;ext.html;969.2100937735745;975.5853762151085;997.2919227348582;1030.809300279448;1038.283584326815;45564.316535252;46736.53263467373;46756.532434675646;46778.2983255251;46938.530614693846;41546;41733.7913310433;41760.37359439611;41932.16135677285;42051;8181.3863960202925;8271.669133234664;8317.708880189164;8331.541765202912;8342.124076971922;8112.188781121899;8165.346772258205;8171.836563268731;8174.836503269931;8199;8705.216530512253;8956.283497320199;8962.462252264851;8970.551472426385;8982.595783189772;8859.335549833788;8921.643134274622;8923.15230053144;8932.732018039469;8944.150305720947;8751.518666473341;8802.07578204292;8853.291736661116;8867.157620026088;8868.423552469068;40199.397009044595;40290.798546007376;40315.798421008;40484.39273410901;40499.59500404988;3865.0530619998;3900.921981560353;3902.804859757001;3904.355781296111;3905.1018265798743;34456.310873782386;34663.13342166441;34799.82600087009;34909.301813963575;34909.30181396383;5503.449655034465;5629.80295689653;5721.856953576153;5725.08398656213;5752.395998420147;234542;234618;234795;235196;235261;54073.72963135238;54253;54395.184072238946;54565.72717136389;58314.416855830896;61293.69353153295;62235.39881410695;62367.6881615589;62494.687526562986;62514.374856251765;18561.25754969813;18575.90712046431;18675.626487470447;18776.155073021746;18935.147918343708;15418.845811541965;15568.610784730472;15569.221538923008;15582.454614088452;15588.532344029698;16284.918575407048;16421.83578164227;16465.423710170086;16535.173241337885;16556.089415082286;6213.875722485615;6261.624302541862;6441.613503189824;6495.967520162463;6509.641969691713;1093.7375029992745;1098.9560417583366;1113.276370359273;1113.5156207049959;1122.814735568622;25948.74051259463;26070.73929260721;26254.212373628823;26282.211533654023;26289.07988220403;1215.343714394235;1222.370479203211;1222.8410306660078;1231.0582404460595;1234.9320787356783;13971.301434928213;14110.435582576787;14156.50452234167;14315.856841431661;14496.492622758153;291641;293667;296290;303111;310980;56760.43239567552;58101.709491452275;64760;65952.67023664947;66236;1564.8356922523199;1574.7795308656798;1581.454398232608;1602.4952140075839;1613.6127329440849;31000.379992399576;31031;31438.214044648154;31505.527417088302;31516.842415787774;43762.78118609387;44100.11799764051;44551.55448445474;44627;44650.10699786051;267614;268006;269433;270028;272548;37984.81007594944;38853.22293554169;38962.415563766;38969.610303896596;39507.60492395039;48249.75875120602;49025.754871225414;49183.75408122937;49463.50536494733;49540.25689614587;35641.82179089192;36335;36361.818190908874;36679.449808252364;36885.81557092197;35287.470687940215;35352.64647353596;35460.46809297914;36125.638743612224;36369.636303637686;41932.16135677331;42863;42870.14259714851;43047.354289685056;43150.78424607857;34118.48822267717;34382.31235375329;34422.48366274458;34628.480572790926;35155.824220878734;25962.610560841982;26009.869950650125;26261.868690656425;26470.470590587694;26765.330866728487 14:40:51 INFO - PID 26583 | |2;jquery.html;625.4027403829343;628.4783629587442;632.5003247434527;642.7204166187706;643.66207740936;24445;24481.877590612043;24982.75017249827;25358.619620705704;25402.61896071558;26790;27182.32044198891;27262.5910611341;27267.86366068167;27268.04561840336;6817.6591170441525;6831.487638427113;6844.315568443166;6851.725930962755;6907.102076730031;6509.674516274191;6807.183138023444;6814.761483348084;6841.247462779091;6853.897191542131;6736.05695202672;6737.258901520829;6761.932380676204;6779.76270830521;6781.864362712743;6740.797776066725;6770.221424536192;6770.424513916323;6794.45644348451;6798.5580937239165;6360.7137678804565;6363.395477429637;6364.745410183587;6367.172267605228;6390.93609063908;29991.250218744488;30301;31083;31364;31410.68589314123;2284.908603655852;2332.778386053339;2336.7546407627124;2336.906523739048;2337.345543247893;20430.897845510826;20931.68602470949;20937.790622093737;20970.161193552238;21022.2642207522;2591.002464051354;2608.3087981684866;2614.6470226519555;2618.973810261892;2671.1719366996294;148316.25841870828;155666;158798;166793.16603417025;166893;16187.433439829785;16329.673406531803;16775;16859.15704214809;17419.129043548026;27155.456890862468;27163.456730865666;27180.184594462196;27254.45491090167;27361;11282.266652667551;11381.54473821038;11473.311601303949;11582.88417115835;11602.883971160349;10682.626108086335;10756.354618722902;10804.1896857736;10842.94578527118;10907.781844363228;9839.80320393588;9842;9874.703758887244;9961.80076398468;10049.296549241482;2877.2950627096075;2947.8820847166303;2988.7398179204324;3030.196997795586;3084.9383012339626;1048.7535429174138;1065.4284929728742;1077.9191560632985;1078.730317420645;1079.4009324824797;20579;20849.270275540282;20999;21186.258480953093;21193.576128477343;1123.9775204496027;1136.8294755786699;1159.2754528419737;1162.1400163878668;1162.5001249462812;11619.6514104577;11882.584109556125;11961.46173422198;12030.699232519257;12031.759364812655;629645;635211;637543;645121;655280;128201;129201;130394;131599;132632.33683831518;1139.8259792413828;1187.0266381567205;1238.3127364312713;1271.7202215512573;1305.7845455499926;22198.667019995035;22351;22515.245426372352;22646.660300095842;22660.773392265866;64420;64487.355126448136;64871.67564162149;64884.026739598;65510.34489655233;83880;84259;84725.57637211775;84859;85155.57422213098;15484.690306194037;15775.132367719885;15832.445864394691;15867.444639437565;15917;23455;23696.40758981039;23792.643110353703;23833.761662383848;23892.40268993289;19616.509587260432;19727.30954416646;19972.90013549923;20010.89994550018;20038.298659546846;17227.913860430617;17625;17857;18207.45377638673;18493.075346232905;19454.8054519453;20391.18435262573;20544;20582;20627.38117856467;15565.45520906808;15585.454509092127;15719.528414147593;15798.21008949525;15928.362865485715;19655.70516442226;19919.900400498485;20004.59990800205;20035.29876454317;20096.19615215375 14:40:51 INFO - PID 26583 | |3;mootools.html;1439.1580925158783;1465.8607432293934;1479.5339468067564;1495.297210311154;1504.9924750376254;17419.12904354782;18075.90962045188;18171.364002259925;18176.636467270648;18184.90873549542;17557.736633950502;17592.20835062422;17663.5584110397;17725.93644381335;17763;2918.4892643787357;2992.730654241118;2999.2052106191877;3013.382256637384;3030.8787648494035;2967.8367689777056;2992.012635830182;3014.502607069831;3021.4108248891366;3022.531507616323;2891.1326602019417;2940.117964610619;2948.631421072366;2966.139819452367;2981.344104297051;2781.429806889603;2791.902283420091;2792.2181789099186;2800.1599520143977;2802.6917039125783;2661.4144888124583;2670.052131493311;2694.743999320081;2697.5953606959115;2699.082312013925;16336;16631.334746610122;16796.2441690123;16807.66384672312;16829.915850420668;8335.583220838995;8642.65429382824;8686.739397818075;8697.826043479095;8701.30389568833;5473.28847249855;5660.60375773696;5866.325372582122;5894.557908156906;5921.319048309457;2141.4218161096574;2153.7630860605323;2198.736151661795;2205.2943058221376;2252.3017864462067;27569;29285.560716589054;30696.2325941851;30714;30827.69172308293;7746.49647772893;7796.220377962159;7811.765647030598;7874.370050396069;8219.794505137299;24289.514209715708;24445.755542444702;24473.755262447503;24563.63154552683;24609.876950615133;9051.683191088281;9115.635374585076;9123.726288211365;9205.125513076247;9208.907910920805;7855.6464959076975;7982.560959147303;8160.4287699861625;8213.260806527442;8223.259906608433;6264.498840092781;6282.591631543935;6333.493320534346;6424.775132870327;6507.121538592324;1889.9433017009512;1897.829195372423;1898.3735367329025;1906.5138389710535;1912.4453908366695;996.7607774134156;1020.0870221152028;1028.4086650176177;1035.9223058270659;1038.4911393417322;8782.736517904474;8853.601587928559;8913.108689131164;8953.820923581492;9126.81746365069;793.500094940184;806.7700705298962;811.6509900742619;813.2883726739103;818.5702506184182;4952.281919121707;5037.647364684511;5047.419546752097;5101.0818052750865;5114.897702045938;25304;25839.354016149748;26455.735442645713;26767.732322676526;26776.464470710478;25738.87130564335;25872;26303.473930521282;26378;26410.207693769218;11006.889931100746;11292.153088518395;12826.358682066046;12830.486780528861;12996.870031299566;10232.48837558134;10365.170786336925;10442.530086146293;10464.162866970471;10641.8935810644;21973.340799776033;22168.445788854762;22613.09547618077;22778.772212277665;23265;23498.64752028755;23577.882110589337;23829.285121446384;23984.40038999039;24068.638970415108;13355.332233388097;13594.45622175102;13597.79603305971;13610.979176561996;13613.659658508617;15898.125603091941;16010.439634612732;16018.839811601734;16194.595135121715;16219.918900405422;12791.36043197855;12814.615561533168;12833.935830320788;12995.480180792661;13360.131591446525;12269.325187114437;12307.446164922421;12468.750624987631;12503.56237531682;12909.741805163656;10987.890121098686;11026.117910567296;11038.944805275922;11106.222564420414;11127.499262533043;8359.874601881098;8393.202645748644;8514.61684224199;8563.229309361937;8682.305415566865;8551.10213427606;8558.914410855812;8572.614232359683;8635.913640863762;8639.04970453237 14:40:51 INFO - PID 26583 | |4;prototype.html;573.8479302984709;575.8128608202335;597.1848426897286;610.5756499233032;619.8264485943937;6383.521235907308;6455.612043410666;6479.1901012373455;6482.740690372391;6485.351464853512;6342.826577083243;6392.55252132351;6415.877221486245;6448.742050317994;6481.189851268591;5281.155015197579;5294.179402192666;5310.867228319285;5330.840074797762;5344.759485823128;4985.501449855004;5257.23770053342;5271.789128434858;5282.550983166417;5287.973560132214;5123.974380128113;5147.253648221005;5159.587233021368;5168.741562921858;5192.428832828386;5140.709945634778;5155.845324640267;5170.836561773608;5179;5197.4022987356375;4675.462321832999;4726.976365118187;4733.408323959505;4742.857714268577;4751.097291514601;6315.431611154972;6356.745730170787;6432.45324147448;6432.646204458753;6440.293322269602;6055.122007308915;6071.362506936796;6099.9085013724825;6105.328413874515;6130.754769809202;6788.639623386406;6799.932000679979;6812.659367031629;6814.727410903558;6855.143107111611;5048.545630893201;5217.50433708797;5244.737763111867;5259.684418934876;5275.815346462894;7003.54476958996;7052.964735176342;7100.928990710078;7161.248068952789;7168.354848063699;5305.204219367049;5332.733363331896;5343.6526625769975;5358.624896257303;5376.768641014014;5414.96938648007;5444.673319600757;5462.426445223274;5477.398235837945;5493.368262649767;6044.607100538451;6047.485963693048;6073.726682299307;6074.696265186812;6098.505866062755;6872.862542749217;6875.48433867462;6910.965445172843;6948.270431604608;6949.2008419031445;1853.499555120137;1854.9814501855078;1869.3176990398679;1876.6622008038685;1877.4555378939954;1300.7447812860635;1338.5047532413068;1349.311850956;1351.8310211223597;1357.395958798345;6325.430711236011;6470.255920569195;6471.288158302583;6472.870542589122;6489.318621544764;6815.250322464525;6863.897041544381;6921.792346229621;6933.653317334113;6983.3714965653335;6457.354264573505;6470.773522926675;6478.416942475105;6480;6563.835904102436;3659.835307411173;3694.5751238607368;3725.5529336479794;3731.253749250161;3733.5519737631657;7214.799486156668;7270.672819723125;7298.817529561803;7318.926810731825;7419.2548756959195;7005.754798582026;7010.614416207056;7135.250798666066;7150.821229469201;7249.4051308712;7266.418686505172;7301.561906285639;7338.192798792129;7342.706291748377;7369.6315184240575;6910.930890691029;6988.231294557493;6997.755078572225;7011.404030657452;7013.4038606719005;6932.341427564374;6954.79135625932;6960.756373527105;6963.860722785617;7025.718971241093;7275.290306778009;7339.816504587215;7348.70605175787;7354.926450735638;7367.8158046049275;5306.867328316668;5311.707856067954;5313.707746074003;5343.332083489564;5358.115910874818;6873.728360253369;7017.7192912282935;7041.295870413122;7113.715451381887;7142.428605711634;6617.569857959217;6687.799366019027;6752.763653272112;6796.320367963164;6816.386525212754;6629;6700.631465269457;6709.563878348087;6714;6714.194296684429;6534.183227096613;6642.169728783902;6672.666366681549;6704.899426508508;6706.66466676674;6786.3892249697765;6835.14560679915;6838.863222735617;6880.759173428906;6893.448524117958;6567.9014814776865;6592.76925307612;6676.9332306676315;6685.264620891795;6741.460683145238 14:40:51 INFO - PID 26583 | |5;yui.html;976.170255283009;987.9110880020799;1016.3292227130096;1018.2007124407342;1026.7535791410062;19080.71378929317;19137.42587722367;21533;21779.23772667957;21840.781592184074;19855;19966.800331996677;19987.100580473878;20079.899600501976;20100.396988090342;999.3510707332922;1022.5551884930079;1029.4132344563602;1030.289100520642;1030.5929157982591;1042.5152304178555;1044.3316277582353;1047.8480620310052;1048.7692707604353;1049.3861091261622;1101.6639924822925;1124.550179928027;1132.1678566253797;1132.184826924617;1132.8244122161036;1112.4271000434783;1122.7529943412437;1124.3984468309457;1124.9325040497515;1124.9381284029375;816.8693009118513;816.8938038055074;817.5912043978011;818.7339114787658;823.5882058970515;21242.83164425956;21940.780592194034;22411.887940560355;22458.55082898349;22507.662385064235;20631.277905273244;21028;21037.68443473349;21045;21255.78744212569;18879.244830206775;19278.036098195033;19361.322353717693;19400.126994285292;19429.125689343873;3978.1446988897237;4108.979455102735;4118.546959834446;4176.352665336878;4180.895477613054;132026;145280;164346.17826910788;174275;175586.1220693901;18485.44543663692;18758;19008.714869276973;19047.1428785705;19047.42857714271;34925;35029.64970350264;35083.824580876935;35211;35481.93554193378;10028.69913902584;10097.44464054484;10110.24173187014;10119.342242754197;10133.442660653734;4706.411698537683;4738.431388233365;4769.713817170981;4788.377510923558;4791.760411979387;6526.869462610816;6581.078648989145;6646.83382915431;6672.633005184664;6681.665916704145;1125.763589646167;1147.20269412759;1163.6334554615269;1178.3342411537453;1180.1738782852037;728.9052423185058;755.3466251692247;760.2549501488462;769.7883082152453;772.9265719756614;12832.80750788739;13046.608601741962;13134.211947283193;13589.592312230649;13788.241646709326;755.6599530211317;757.9242075792376;764.3541207679502;780.5862892666782;784.4861615641764;6383.265924418752;6452;6460.063290822898;6592.571482853599;6598.60408375499;154708;156896;158172;158710;166007;139395;139534;139955;141824;145973.27013364865;120802.39598802125;122270;122324;122375;125260.37369813092;12222.388880556115;12346.444410001392;12459.314737689514;12517.311547864954;12631.87368126307;59723;60145;60192;60908.086378705244;61572.076418852856;75315.62342188254;76152.61923690345;77110;78030.60984695268;79048.60475697585;18008.819911800714;18238.635227295646;18391.90804045971;18450.35423760162;18535.72196417028;20167.092480838102;20343.389698309074;20413.48966275855;20424.285150019678;20565.794342056386;18325.99207043572;18344.174512146717;18480.722789157906;18501.53746156357;18586.442406727278;18298.817011829713;18514.814851851308;18578.25686972506;18620;18622.441326760218;15490.767638485206;15493.07041577509;15578.532644020697;15647.061176329456;15756.448524302054;12342.197757145757;12625.149329454605;12682.619521414372;12725.427355768827;12727.872721272668;13581.660458488617;13814.65463363424;13834.723305534035;13858.307084645527;13889.652758681113 14:40:51 INFO - PID 26583 | __end_tp_report 14:40:51 INFO - PID 26583 | __start_cc_report 14:40:51 INFO - PID 26583 | _x_x_mozilla_cycle_collect,252 14:40:51 INFO - PID 26583 | __end_cc_report 14:40:51 INFO - PID 26583 | __startTimestamp1507844451872__endTimestamp 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | ------- Summary: start ------- 14:40:51 INFO - PID 26583 | Number of tests: 6 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | [#0] dojo.html Cycles:165 Average:6439.54 Median:6662.53 stddev:731.51 (11.0%) stddev-sans-first:706.38 14:40:51 INFO - PID 26583 | Values: 3912.8 3931.2 3988.4 3997.2 4015.7 6333.2 6342.8 6357.8 6434.3 6434.9 6374.1 6400.7 6453.5 6462.7 6472.0 5709.3 5732.5 5800.2 5827.5 5862.8 5779.5 5804.5 5870.4 5873.1 5926.6 5943.7 5988.9 5991.5 5994.8 5997.6 5872.2 5886.6 5908.4 5950.0 5972.1 5758.9 5765.1 5768.2 5826.2 5859.4 6407.1 6415.7 6435.6 6448.9 6450.2 6955.3 6975.7 6988.5 7045.5 7069.5 6965.9 6986.7 7038.2 7060.3 7088.5 6339.7 6406.1 6409.4 6477.6 6532.8 7080.5 7086.2 7091.8 7179.0 7211.1 6811.0 6826.4 6888.4 6896.1 6897.9 6939.1 6954.0 6980.7 7008.7 7018.2 6914.1 6997.1 7007.3 7008.7 7011.4 6854.0 6914.0 6923.3 7020.3 7030.9 5080.7 5082.6 5083.4 5110.2 5131.9 4710.9 4779.6 4801.2 4844.2 4857.0 6390.0 6513.9 6527.9 6608.1 6610.1 6921.7 6926.0 6941.9 6950.0 6990.3 6405.2 6437.0 6504.4 6522.3 6539.2 5836.5 5865.3 5925.5 5928.6 5942.8 7206.5 7224.5 7302.3 7399.4 7404.7 6806.8 6844.9 6851.5 6941.2 7044.4 7197.2 7238.5 7250.6 7257.8 7345.9 6777.3 6797.2 6852.8 6865.7 6915.8 6938.2 6980.0 7006.2 7017.8 7023.4 6704.4 6747.9 6751.7 6755.1 6764.9 6684.5 6714.2 6754.5 6759.6 6768.9 6617.9 6625.3 6632.7 6714.4 6725.1 6593.9 6738.1 6779.7 6823.5 6832.5 6584.0 6588.8 6646.8 6662.5 6665.7 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | [#1] ext.html Cycles:180 Average:45584.27 Median:38966.01 stddev:70017.10 (179.7%) stddev-sans-first:70133.38 14:40:51 INFO - PID 26583 | Values: 969.2 975.6 997.3 1030.8 1038.3 45564.3 46736.5 46756.5 46778.3 46938.5 41546.0 41733.8 41760.4 41932.2 42051.0 8181.4 8271.7 8317.7 8331.5 8342.1 8112.2 8165.3 8171.8 8174.8 8199.0 8705.2 8956.3 8962.5 8970.6 8982.6 8859.3 8921.6 8923.2 8932.7 8944.2 8751.5 8802.1 8853.3 8867.2 8868.4 40199.4 40290.8 40315.8 40484.4 40499.6 3865.1 3900.9 3902.8 3904.4 3905.1 34456.3 34663.1 34799.8 34909.3 34909.3 5503.4 5629.8 5721.9 5725.1 5752.4 234542.0 234618.0 234795.0 235196.0 235261.0 54073.7 54253.0 54395.2 54565.7 58314.4 61293.7 62235.4 62367.7 62494.7 62514.4 18561.3 18575.9 18675.6 18776.2 18935.1 15418.8 15568.6 15569.2 15582.5 15588.5 16284.9 16421.8 16465.4 16535.2 16556.1 6213.9 6261.6 6441.6 6496.0 6509.6 1093.7 1099.0 1113.3 1113.5 1122.8 25948.7 26070.7 26254.2 26282.2 26289.1 1215.3 1222.4 1222.8 1231.1 1234.9 13971.3 14110.4 14156.5 14315.9 14496.5 291641.0 293667.0 296290.0 303111.0 310980.0 56760.4 58101.7 64760.0 65952.7 66236.0 1564.8 1574.8 1581.5 1602.5 1613.6 31000.4 31031.0 31438.2 31505.5 31516.8 43762.8 44100.1 44551.6 44627.0 44650.1 267614.0 268006.0 269433.0 270028.0 272548.0 37984.8 38853.2 38962.4 38969.6 39507.6 48249.8 49025.8 49183.8 49463.5 49540.3 35641.8 36335.0 36361.8 36679.4 36885.8 35287.5 35352.6 35460.5 36125.6 36369.6 41932.2 42863.0 42870.1 43047.4 43150.8 34118.5 34382.3 34422.5 34628.5 35155.8 25962.6 26009.9 26261.9 26470.5 26765.3 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | [#2] jquery.html Cycles:180 Average:41491.15 Median:12472.84 stddev:107048.33 (858.3%) stddev-sans-first:107304.65 14:40:51 INFO - PID 26583 | Values: 625.4 628.5 632.5 642.7 643.7 24445.0 24481.9 24982.8 25358.6 25402.6 26790.0 27182.3 27262.6 27267.9 27268.0 6817.7 6831.5 6844.3 6851.7 6907.1 6509.7 6807.2 6814.8 6841.2 6853.9 6736.1 6737.3 6761.9 6779.8 6781.9 6740.8 6770.2 6770.4 6794.5 6798.6 6360.7 6363.4 6364.7 6367.2 6390.9 29991.3 30301.0 31083.0 31364.0 31410.7 2284.9 2332.8 2336.8 2336.9 2337.3 20430.9 20931.7 20937.8 20970.2 21022.3 2591.0 2608.3 2614.6 2619.0 2671.2 148316.3 155666.0 158798.0 166793.2 166893.0 16187.4 16329.7 16775.0 16859.2 17419.1 27155.5 27163.5 27180.2 27254.5 27361.0 11282.3 11381.5 11473.3 11582.9 11602.9 10682.6 10756.4 10804.2 10842.9 10907.8 9839.8 9842.0 9874.7 9961.8 10049.3 2877.3 2947.9 2988.7 3030.2 3084.9 1048.8 1065.4 1077.9 1078.7 1079.4 20579.0 20849.3 20999.0 21186.3 21193.6 1124.0 1136.8 1159.3 1162.1 1162.5 11619.7 11882.6 11961.5 12030.7 12031.8 629645.0 635211.0 637543.0 645121.0 655280.0 128201.0 129201.0 130394.0 131599.0 132632.3 1139.8 1187.0 1238.3 1271.7 1305.8 22198.7 22351.0 22515.2 22646.7 22660.8 64420.0 64487.4 64871.7 64884.0 65510.3 83880.0 84259.0 84725.6 84859.0 85155.6 15484.7 15775.1 15832.4 15867.4 15917.0 23455.0 23696.4 23792.6 23833.8 23892.4 19616.5 19727.3 19972.9 20010.9 20038.3 17227.9 17625.0 17857.0 18207.5 18493.1 19454.8 20391.2 20544.0 20582.0 20627.4 15565.5 15585.5 15719.5 15798.2 15928.4 19655.7 19919.9 20004.6 20035.3 20096.2 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | [#3] mootools.html Cycles:180 Average:10912.76 Median:26432.97 stddev:8144.87 (30.8%) stddev-sans-first:8136.62 14:40:51 INFO - PID 26583 | Values: 1439.2 1465.9 1479.5 1495.3 1505.0 17419.1 18075.9 18171.4 18176.6 18184.9 17557.7 17592.2 17663.6 17725.9 17763.0 2918.5 2992.7 2999.2 3013.4 3030.9 2967.8 2992.0 3014.5 3021.4 3022.5 2891.1 2940.1 2948.6 2966.1 2981.3 2781.4 2791.9 2792.2 2800.2 2802.7 2661.4 2670.1 2694.7 2697.6 2699.1 16336.0 16631.3 16796.2 16807.7 16829.9 8335.6 8642.7 8686.7 8697.8 8701.3 5473.3 5660.6 5866.3 5894.6 5921.3 2141.4 2153.8 2198.7 2205.3 2252.3 27569.0 29285.6 30696.2 30714.0 30827.7 7746.5 7796.2 7811.8 7874.4 8219.8 24289.5 24445.8 24473.8 24563.6 24609.9 9051.7 9115.6 9123.7 9205.1 9208.9 7855.6 7982.6 8160.4 8213.3 8223.3 6264.5 6282.6 6333.5 6424.8 6507.1 1889.9 1897.8 1898.4 1906.5 1912.4 996.8 1020.1 1028.4 1035.9 1038.5 8782.7 8853.6 8913.1 8953.8 9126.8 793.5 806.8 811.7 813.3 818.6 4952.3 5037.6 5047.4 5101.1 5114.9 25304.0 25839.4 26455.7 26767.7 26776.5 25738.9 25872.0 26303.5 26378.0 26410.2 11006.9 11292.2 12826.4 12830.5 12996.9 10232.5 10365.2 10442.5 10464.2 10641.9 21973.3 22168.4 22613.1 22778.8 23265.0 23498.6 23577.9 23829.3 23984.4 24068.6 13355.3 13594.5 13597.8 13611.0 13613.7 15898.1 16010.4 16018.8 16194.6 16219.9 12791.4 12814.6 12833.9 12995.5 13360.1 12269.3 12307.4 12468.8 12503.6 12909.7 10987.9 11026.1 11038.9 11106.2 11127.5 8359.9 8393.2 8514.6 8563.2 8682.3 8551.1 8558.9 8572.6 8635.9 8639.0 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | [#4] prototype.html Cycles:180 Average:5837.99 Median:6472.08 stddev:1627.90 (25.2%) stddev-sans-first:1583.79 14:40:51 INFO - PID 26583 | Values: 573.8 575.8 597.2 610.6 619.8 6383.5 6455.6 6479.2 6482.7 6485.4 6342.8 6392.6 6415.9 6448.7 6481.2 5281.2 5294.2 5310.9 5330.8 5344.8 4985.5 5257.2 5271.8 5282.6 5288.0 5124.0 5147.3 5159.6 5168.7 5192.4 5140.7 5155.8 5170.8 5179.0 5197.4 4675.5 4727.0 4733.4 4742.9 4751.1 6315.4 6356.7 6432.5 6432.6 6440.3 6055.1 6071.4 6099.9 6105.3 6130.8 6788.6 6799.9 6812.7 6814.7 6855.1 5048.5 5217.5 5244.7 5259.7 5275.8 7003.5 7053.0 7100.9 7161.2 7168.4 5305.2 5332.7 5343.7 5358.6 5376.8 5415.0 5444.7 5462.4 5477.4 5493.4 6044.6 6047.5 6073.7 6074.7 6098.5 6872.9 6875.5 6911.0 6948.3 6949.2 1853.5 1855.0 1869.3 1876.7 1877.5 1300.7 1338.5 1349.3 1351.8 1357.4 6325.4 6470.3 6471.3 6472.9 6489.3 6815.3 6863.9 6921.8 6933.7 6983.4 6457.4 6470.8 6478.4 6480.0 6563.8 3659.8 3694.6 3725.6 3731.3 3733.6 7214.8 7270.7 7298.8 7318.9 7419.3 7005.8 7010.6 7135.3 7150.8 7249.4 7266.4 7301.6 7338.2 7342.7 7369.6 6910.9 6988.2 6997.8 7011.4 7013.4 6932.3 6954.8 6960.8 6963.9 7025.7 7275.3 7339.8 7348.7 7354.9 7367.8 5306.9 5311.7 5313.7 5343.3 5358.1 6873.7 7017.7 7041.3 7113.7 7142.4 6617.6 6687.8 6752.8 6796.3 6816.4 6629.0 6700.6 6709.6 6714.0 6714.2 6534.2 6642.2 6672.7 6704.9 6706.7 6786.4 6835.1 6838.9 6880.8 6893.4 6567.9 6592.8 6676.9 6685.3 6741.5 14:40:51 INFO - PID 26583 | 14:40:51 INFO - PID 26583 | [#5] yui.html Cycles:180 Average:29449.21 Median:18603.22 stddev:44325.58 (238.3%) stddev-sans-first:44398.36 14:40:51 INFO - PID 26583 | Values: 976.2 987.9 1016.3 1018.2 1026.8 19080.7 19137.4 21533.0 21779.2 21840.8 19855.0 19966.8 19987.1 20079.9 20100.4 999.4 1022.6 1029.4 1030.3 1030.6 1042.5 1044.3 1047.8 1048.8 1049.4 1101.7 1124.6 1132.2 1132.2 1132.8 1112.4 1122.8 1124.4 1124.9 1124.9 816.9 816.9 817.6 818.7 823.6 21242.8 21940.8 22411.9 22458.6 22507.7 20631.3 21028.0 21037.7 21045.0 21255.8 18879.2 19278.0 19361.3 19400.1 19429.1 3978.1 4109.0 4118.5 4176.4 4180.9 132026.0 145280.0 164346.2 174275.0 175586.1 18485.4 18758.0 19008.7 19047.1 19047.4 34925.0 35029.6 35083.8 35211.0 35481.9 10028.7 10097.4 10110.2 10119.3 10133.4 4706.4 4738.4 4769.7 4788.4 4791.8 6526.9 6581.1 6646.8 6672.6 6681.7 1125.8 1147.2 1163.6 1178.3 1180.2 728.9 755.3 760.3 769.8 772.9 12832.8 13046.6 13134.2 13589.6 13788.2 755.7 757.9 764.4 780.6 784.5 6383.3 6452.0 6460.1 6592.6 6598.6 154708.0 156896.0 158172.0 158710.0 166007.0 139395.0 139534.0 139955.0 141824.0 145973.3 120802.4 122270.0 122324.0 122375.0 125260.4 12222.4 12346.4 12459.3 12517.3 12631.9 59723.0 60145.0 60192.0 60908.1 61572.1 75315.6 76152.6 77110.0 78030.6 79048.6 18008.8 18238.6 18391.9 18450.4 18535.7 20167.1 20343.4 20413.5 20424.3 20565.8 18326.0 18344.2 18480.7 18501.5 18586.4 18298.8 18514.8 18578.3 18620.0 18622.4 15490.8 15493.1 15578.5 15647.1 15756.4 12342.2 12625.1 12682.6 12725.4 12727.9 13581.7 13814.7 13834.7 13858.3 13889.7 14:40:51 INFO - PID 26583 | -------- Summary: end -------- 14:40:51 INFO - PID 26583 | 14:40:52 INFO - TEST-INFO | 26583: exit 0 14:40:52 INFO - TEST-OK | dromaeo_css | took 1105929ms 14:40:52 INFO - TEST-START | kraken 14:40:52 INFO - Initialising browser for kraken test... 14:40:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html -profile /tmp/tmpyNykCv/profile 14:40:52 INFO - TEST-INFO | started process 26949 (/builds/slave/test/build/application/firefox/firefox http://localhost:55708/getInfo.html) 14:40:56 INFO - TEST-INFO | 26949: exit 0 14:40:56 INFO - Browser initialized. 14:40:56 INFO - Running cycle 1/1 for kraken test... 14:40:56 INFO - Using env: {'DISPLAY': ':0', 14:40:56 INFO - 'HOME': '/home/cltbld', 14:40:56 INFO - 'JSGC_DISABLE_POISONING': '1', 14:40:56 INFO - 'LANG': 'en_US.UTF-8', 14:40:56 INFO - 'LANGUAGE': 'en_US:en', 14:40:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:40:56 INFO - 'LOGNAME': 'cltbld', 14:40:56 INFO - 'MAIL': '/var/mail/cltbld', 14:40:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:56 INFO - 'MOZ_CRASHREPORTER': '1', 14:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:40:56 INFO - 'MOZ_NO_REMOTE': '1', 14:40:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:56 INFO - 'NO_EM_RESTART': '1', 14:40:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:56 INFO - 'PWD': '/builds/slave/test', 14:40:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:56 INFO - 'RUST_BACKTRACE': 'full', 14:40:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:40:56 INFO - 'SHELL': '/bin/bash', 14:40:56 INFO - 'SHLVL': '1', 14:40:56 INFO - 'TERM': 'linux', 14:40:56 INFO - 'TMOUT': '86400', 14:40:56 INFO - 'USER': 'cltbld', 14:40:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507837275.569208-155156370', 14:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:56 INFO - '_': '/tools/buildbot/bin/python'} 14:40:56 INFO - TEST-INFO | started process 27178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyNykCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:57 INFO - PID 27178 | 14:40:57 INFO - PID 27178 | (/builds/slave/test/build/application/firefox/firefox:27226): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:40:57 INFO - PID 27178 | 14:41:07 INFO - PID 27178 | RSS: Main: 143708160 14:41:07 INFO - PID 27178 | 14:41:10 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:11 INFO - PID 27178 | RSS: Main: 150413312 14:41:11 INFO - PID 27178 | 14:41:13 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-dft) 14:41:14 INFO - PID 27178 | RSS: Main: 150470656 14:41:14 INFO - PID 27178 | 14:41:17 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-fft) 14:41:17 INFO - PID 27178 | RSS: Main: 152002560 14:41:17 INFO - PID 27178 | 14:41:19 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55708/tests/kraken/driver.html?testName=audio-oscillator) 14:41:20 INFO - PID 27178 | RSS: Main: 152031232 14:41:20 INFO - PID 27178 | 14:41:22 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:22 INFO - PID 27178 | RSS: Main: 151801856 14:41:22 INFO - PID 27178 | 14:41:25 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55708/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:26 INFO - PID 27178 | RSS: Main: 152358912 14:41:26 INFO - PID 27178 | 14:41:30 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55708/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:30 INFO - PID 27178 | RSS: Main: 151986176 14:41:30 INFO - PID 27178 | 14:41:33 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55708/tests/kraken/driver.html?testName=json-parse-financial) 14:41:34 INFO - PID 27178 | RSS: Main: 153366528 14:41:34 INFO - PID 27178 | 14:41:35 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:36 INFO - PID 27178 | RSS: Main: 153403392 14:41:36 INFO - PID 27178 | 14:41:37 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:38 INFO - PID 27178 | RSS: Main: 153595904 14:41:38 INFO - PID 27178 | 14:41:40 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:41 INFO - PID 27178 | RSS: Main: 150319104 14:41:41 INFO - PID 27178 | 14:41:43 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:43 INFO - PID 27178 | RSS: Main: 150261760 14:41:43 INFO - PID 27178 | 14:41:46 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:47 INFO - PID 27178 | RSS: Main: 151347200 14:41:47 INFO - PID 27178 | 14:41:48 INFO - PID 27178 | Cycle 1(1): loaded http://localhost:55708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55708/tests/kraken/driver.html?testName=ai-astar) 14:41:49 INFO - PID 27178 | RSS: Main: 152764416 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | __start_tp_report 14:41:49 INFO - PID 27178 | _x_x_mozilla_page_load 14:41:49 INFO - PID 27178 | _x_x_mozilla_page_load_details 14:41:49 INFO - PID 27178 | |i|pagename|runs| 14:41:49 INFO - PID 27178 | |0;ai-astar;104;104;105;104;105;106;106;105;105;106 14:41:49 INFO - PID 27178 | |1;audio-beat-detection;111;111;116;111;113;111;109;111;112;141 14:41:49 INFO - PID 27178 | |2;audio-dft;160;161;163;161;162;161;162;162;161;161 14:41:49 INFO - PID 27178 | |3;audio-fft;74;74;74;74;73;72;73;73;76;73 14:41:49 INFO - PID 27178 | |4;audio-oscillator;78;77;77;77;77;76;77;77;87;77 14:41:49 INFO - PID 27178 | |5;imaging-gaussian-blur;110;115;114;110;114;114;114;114;113;114 14:41:49 INFO - PID 27178 | |6;imaging-darkroom;148;148;148;154;148;148;147;149;148;148 14:41:49 INFO - PID 27178 | |7;imaging-desaturate;94;94;95;94;94;93;94;94;94;94 14:41:49 INFO - PID 27178 | |8;json-parse-financial;42;43;43;43;43;44;45;43;43;42 14:41:49 INFO - PID 27178 | |9;json-stringify-tinderbox;37;38;38;38;38;37;38;37;39;37 14:41:49 INFO - PID 27178 | |10;stanford-crypto-aes;72;69;70;70;68;70;69;77;71;75 14:41:49 INFO - PID 27178 | |11;stanford-crypto-ccm;108;107;107;100;102;109;102;110;110;103 14:41:49 INFO - PID 27178 | |12;stanford-crypto-pbkdf2;148;151;148;147;158;151;144;150;150;153 14:41:49 INFO - PID 27178 | |13;stanford-crypto-sha256-iterative;60;57;59;63;59;59;59;59;59;59 14:41:49 INFO - PID 27178 | __end_tp_report 14:41:49 INFO - PID 27178 | __start_cc_report 14:41:49 INFO - PID 27178 | _x_x_mozilla_cycle_collect,680 14:41:49 INFO - PID 27178 | __end_cc_report 14:41:49 INFO - PID 27178 | __startTimestamp1507844509144__endTimestamp 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | ------- Summary: start ------- 14:41:49 INFO - PID 27178 | Number of tests: 14 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#0] ai-astar Cycles:10 Average:105.00 Median:105.00 stddev:0.82 (0.8%) stddev-sans-first:0.78 14:41:49 INFO - PID 27178 | Values: 104.0 104.0 105.0 104.0 105.0 106.0 106.0 105.0 105.0 106.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#1] audio-beat-detection Cycles:10 Average:114.60 Median:111.50 stddev:9.45 (8.5%) stddev-sans-first:9.94 14:41:49 INFO - PID 27178 | Values: 111.0 111.0 116.0 111.0 113.0 111.0 109.0 111.0 112.0 141.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.73 14:41:49 INFO - PID 27178 | Values: 160.0 161.0 163.0 161.0 162.0 161.0 162.0 162.0 161.0 161.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#3] audio-fft Cycles:10 Average:73.60 Median:74.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 14:41:49 INFO - PID 27178 | Values: 74.0 74.0 74.0 74.0 73.0 72.0 73.0 73.0 76.0 73.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:77.00 stddev:3.20 (4.2%) stddev-sans-first:3.39 14:41:49 INFO - PID 27178 | Values: 78.0 77.0 77.0 77.0 77.0 76.0 77.0 77.0 87.0 77.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.75 (1.5%) stddev-sans-first:1.42 14:41:49 INFO - PID 27178 | Values: 110.0 115.0 114.0 110.0 114.0 114.0 114.0 114.0 113.0 114.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:1.96 (1.3%) stddev-sans-first:2.06 14:41:49 INFO - PID 27178 | Values: 148.0 148.0 148.0 154.0 148.0 148.0 147.0 149.0 148.0 148.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:41:49 INFO - PID 27178 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#8] json-parse-financial Cycles:10 Average:43.10 Median:43.00 stddev:0.88 (2.0%) stddev-sans-first:0.83 14:41:49 INFO - PID 27178 | Values: 42.0 43.0 43.0 43.0 43.0 44.0 45.0 43.0 43.0 42.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.67 14:41:49 INFO - PID 27178 | Values: 37.0 38.0 38.0 38.0 38.0 37.0 38.0 37.0 39.0 37.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#10] stanford-crypto-aes Cycles:10 Average:71.10 Median:70.50 stddev:2.85 (4.0%) stddev-sans-first:3.00 14:41:49 INFO - PID 27178 | Values: 72.0 69.0 70.0 70.0 68.0 70.0 69.0 77.0 71.0 75.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#11] stanford-crypto-ccm Cycles:10 Average:105.80 Median:107.50 stddev:3.71 (3.4%) stddev-sans-first:3.84 14:41:49 INFO - PID 27178 | Values: 108.0 107.0 107.0 100.0 102.0 109.0 102.0 110.0 110.0 103.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:150.50 stddev:3.77 (2.5%) stddev-sans-first:3.93 14:41:49 INFO - PID 27178 | Values: 148.0 151.0 148.0 147.0 158.0 151.0 144.0 150.0 150.0 153.0 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.00 stddev:1.49 (2.5%) stddev-sans-first:1.56 14:41:49 INFO - PID 27178 | Values: 60.0 57.0 59.0 63.0 59.0 59.0 59.0 59.0 59.0 59.0 14:41:49 INFO - PID 27178 | -------- Summary: end -------- 14:41:49 INFO - PID 27178 | 14:41:49 INFO - PID 27178 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:41:49 INFO - TEST-INFO | 27178: exit 0 14:41:49 INFO - TEST-OK | kraken | took 57312ms 14:41:49 INFO - SUITE-END | took 1163s 14:41:49 INFO - Completed test suite (00:19:23) 14:41:49 INFO - javascript benchmark 14:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9387.5975972739, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3912.8434862605486, 3931.233409485151, 3988.361862102064, 3997.160596274782, 4015.6787457003443, 6333.176687030686, 6342.841428964267, 6357.8092657220295, 6434.292227854938, 6434.903476447857, 6374.139491168691, 6400.679966001693, 6453.451456626192, 6462.741490340381, 6472.029195620659, 5709.314882214119, 5732.455416735414, 5800.15897694834, 5827.475527202551, 5862.794802181925, 5779.479846813786, 5804.535637149018, 5870.442307980735, 5873.119032145191, 5926.585139040269, 5943.702814859262, 5988.940110598904, 5991.490723288504, 5994.820155395345, 5997.550183736215, 5872.207252020987, 5886.558508111866, 5908.379620139866, 5949.9702501487645, 5972.134040564116, 5758.856028599319, 5765.106408506688, 5768.221290125864, 5826.213461182729, 5859.384764599741, 6407.135036770023, 6415.743370265184, 6435.613863168225, 6448.93551064488, 6450.225972883284, 6955.269696681877, 6975.651217439107, 6988.54574452664, 7045.471589630798, 7069.540479868792, 6965.860682786367, 6986.650667466606, 7038.15542134942, 7060.3292687194635, 7088.503804733671, 6339.683015849189, 6406.103145559626, 6409.359064093554, 6477.611343319416, 6532.8366790830605, 7080.504364694525, 7086.2205157432645, 7091.751788687371, 7178.964105179545, 7211.062561866924, 6810.965945170243, 6826.385625293748, 6888.380045795902, 6896.103506544117, 6897.896336586122, 6939.063226464464, 6954.026436298922, 6980.685869135901, 7008.719651213894, 7018.192907815666, 6914.101166848278, 6997.1253593300835, 7007.334303241184, 7008.684609192598, 7011.439084873198, 6854.0, 6913.965430172817, 6923.342282483156, 7020.297970203041, 7030.929690703129, 5080.669756465818, 5082.567981721521, 5083.364579427572, 5110.233464980282, 5131.923021154686, 4710.882227944328, 4779.569838714463, 4801.159797035505, 4844.2007068833245, 4857.0, 6390.041493775971, 6513.869722605521, 6527.934720652827, 6608.074869518271, 6610.140681711347, 6921.688524016431, 6925.965370173117, 6941.930580694229, 6950.0, 6990.335918087875, 6405.231372235268, 6436.967815160988, 6504.38208370204, 6522.282548919615, 6539.215294164635, 5836.503897168788, 5865.3254875689845, 5925.525957923356, 5928.614640048383, 5942.762289508371, 7206.531575447579, 7224.4942854000765, 7302.2697730226555, 7399.4450416219, 7404.666789994463, 6806.7957961261245, 6844.939034449668, 6851.520393572402, 6941.201761797458, 7044.436445084483, 7197.244289349543, 7238.493305468567, 7250.60121693312, 7257.782266532013, 7345.853082938204, 6777.322267773183, 6797.218319893275, 6852.760153394607, 6865.691043902936, 6915.827104322432, 6938.23679395256, 6979.965100174467, 7006.159260888726, 7017.824554385977, 7023.367896889305, 6704.363085506869, 6747.932520674927, 6751.729930802713, 6755.121834161528, 6764.932350676627, 6684.532082754161, 6714.160729908762, 6754.527183097136, 6759.594424334556, 6768.898466522907, 6617.867642647217, 6625.271220165681, 6632.668366581555, 6714.3957043866285, 6725.092112564741, 6593.901091483535, 6738.090357801634, 6779.661016949231, 6823.488238382042, 6832.487563432663, 6584.045313429621, 6588.781075501048, 6646.83382915431, 6662.533622646368, 6665.733370665119], "value": 6391.762409536287, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.2100937735745, 975.5853762151085, 997.2919227348582, 1030.809300279448, 1038.283584326815, 45564.316535252, 46736.53263467373, 46756.532434675646, 46778.2983255251, 46938.530614693846, 41546.0, 41733.7913310433, 41760.37359439611, 41932.16135677285, 42051.0, 8181.3863960202925, 8271.669133234664, 8317.708880189164, 8331.541765202912, 8342.124076971922, 8112.188781121899, 8165.346772258205, 8171.836563268731, 8174.836503269931, 8199.0, 8705.216530512253, 8956.283497320199, 8962.462252264851, 8970.551472426385, 8982.595783189772, 8859.335549833788, 8921.643134274622, 8923.15230053144, 8932.732018039469, 8944.150305720947, 8751.518666473341, 8802.07578204292, 8853.291736661116, 8867.157620026088, 8868.423552469068, 40199.397009044595, 40290.798546007376, 40315.798421008, 40484.39273410901, 40499.59500404988, 3865.0530619998, 3900.921981560353, 3902.804859757001, 3904.355781296111, 3905.1018265798743, 34456.310873782386, 34663.13342166441, 34799.82600087009, 34909.301813963575, 34909.30181396383, 5503.449655034465, 5629.80295689653, 5721.856953576153, 5725.08398656213, 5752.395998420147, 234542.0, 234618.0, 234795.0, 235196.0, 235261.0, 54073.72963135238, 54253.0, 54395.184072238946, 54565.72717136389, 58314.416855830896, 61293.69353153295, 62235.39881410695, 62367.6881615589, 62494.687526562986, 62514.374856251765, 18561.25754969813, 18575.90712046431, 18675.626487470447, 18776.155073021746, 18935.147918343708, 15418.845811541965, 15568.610784730472, 15569.221538923008, 15582.454614088452, 15588.532344029698, 16284.918575407048, 16421.83578164227, 16465.423710170086, 16535.173241337885, 16556.089415082286, 6213.875722485615, 6261.624302541862, 6441.613503189824, 6495.967520162463, 6509.641969691713, 1093.7375029992745, 1098.9560417583366, 1113.276370359273, 1113.5156207049959, 1122.814735568622, 25948.74051259463, 26070.73929260721, 26254.212373628823, 26282.211533654023, 26289.07988220403, 1215.343714394235, 1222.370479203211, 1222.8410306660078, 1231.0582404460595, 1234.9320787356783, 13971.301434928213, 14110.435582576787, 14156.50452234167, 14315.856841431661, 14496.492622758153, 291641.0, 293667.0, 296290.0, 303111.0, 310980.0, 56760.43239567552, 58101.709491452275, 64760.0, 65952.67023664947, 66236.0, 1564.8356922523199, 1574.7795308656798, 1581.454398232608, 1602.4952140075839, 1613.6127329440849, 31000.379992399576, 31031.0, 31438.214044648154, 31505.527417088302, 31516.842415787774, 43762.78118609387, 44100.11799764051, 44551.55448445474, 44627.0, 44650.10699786051, 267614.0, 268006.0, 269433.0, 270028.0, 272548.0, 37984.81007594944, 38853.22293554169, 38962.415563766, 38969.610303896596, 39507.60492395039, 48249.75875120602, 49025.754871225414, 49183.75408122937, 49463.50536494733, 49540.25689614587, 35641.82179089192, 36335.0, 36361.818190908874, 36679.449808252364, 36885.81557092197, 35287.470687940215, 35352.64647353596, 35460.46809297914, 36125.638743612224, 36369.636303637686, 41932.16135677331, 42863.0, 42870.14259714851, 43047.354289685056, 43150.78424607857, 34118.48822267717, 34382.31235375329, 34422.48366274458, 34628.480572790926, 35155.824220878734, 25962.610560841982, 26009.869950650125, 26261.868690656425, 26470.470590587694, 26765.330866728487], "value": 19675.23171824558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.4027403829343, 628.4783629587442, 632.5003247434527, 642.7204166187706, 643.66207740936, 24445.0, 24481.877590612043, 24982.75017249827, 25358.619620705704, 25402.61896071558, 26790.0, 27182.32044198891, 27262.5910611341, 27267.86366068167, 27268.04561840336, 6817.6591170441525, 6831.487638427113, 6844.315568443166, 6851.725930962755, 6907.102076730031, 6509.674516274191, 6807.183138023444, 6814.761483348084, 6841.247462779091, 6853.897191542131, 6736.05695202672, 6737.258901520829, 6761.932380676204, 6779.76270830521, 6781.864362712743, 6740.797776066725, 6770.221424536192, 6770.424513916323, 6794.45644348451, 6798.5580937239165, 6360.7137678804565, 6363.395477429637, 6364.745410183587, 6367.172267605228, 6390.93609063908, 29991.250218744488, 30301.0, 31083.0, 31364.0, 31410.68589314123, 2284.908603655852, 2332.778386053339, 2336.7546407627124, 2336.906523739048, 2337.345543247893, 20430.897845510826, 20931.68602470949, 20937.790622093737, 20970.161193552238, 21022.2642207522, 2591.002464051354, 2608.3087981684866, 2614.6470226519555, 2618.973810261892, 2671.1719366996294, 148316.25841870828, 155666.0, 158798.0, 166793.16603417025, 166893.0, 16187.433439829785, 16329.673406531803, 16775.0, 16859.15704214809, 17419.129043548026, 27155.456890862468, 27163.456730865666, 27180.184594462196, 27254.45491090167, 27361.0, 11282.266652667551, 11381.54473821038, 11473.311601303949, 11582.88417115835, 11602.883971160349, 10682.626108086335, 10756.354618722902, 10804.1896857736, 10842.94578527118, 10907.781844363228, 9839.80320393588, 9842.0, 9874.703758887244, 9961.80076398468, 10049.296549241482, 2877.2950627096075, 2947.8820847166303, 2988.7398179204324, 3030.196997795586, 3084.9383012339626, 1048.7535429174138, 1065.4284929728742, 1077.9191560632985, 1078.730317420645, 1079.4009324824797, 20579.0, 20849.270275540282, 20999.0, 21186.258480953093, 21193.576128477343, 1123.9775204496027, 1136.8294755786699, 1159.2754528419737, 1162.1400163878668, 1162.5001249462812, 11619.6514104577, 11882.584109556125, 11961.46173422198, 12030.699232519257, 12031.759364812655, 629645.0, 635211.0, 637543.0, 645121.0, 655280.0, 128201.0, 129201.0, 130394.0, 131599.0, 132632.33683831518, 1139.8259792413828, 1187.0266381567205, 1238.3127364312713, 1271.7202215512573, 1305.7845455499926, 22198.667019995035, 22351.0, 22515.245426372352, 22646.660300095842, 22660.773392265866, 64420.0, 64487.355126448136, 64871.67564162149, 64884.026739598, 65510.34489655233, 83880.0, 84259.0, 84725.57637211775, 84859.0, 85155.57422213098, 15484.690306194037, 15775.132367719885, 15832.445864394691, 15867.444639437565, 15917.0, 23455.0, 23696.40758981039, 23792.643110353703, 23833.761662383848, 23892.40268993289, 19616.509587260432, 19727.30954416646, 19972.90013549923, 20010.89994550018, 20038.298659546846, 17227.913860430617, 17625.0, 17857.0, 18207.45377638673, 18493.075346232905, 19454.8054519453, 20391.18435262573, 20544.0, 20582.0, 20627.38117856467, 15565.45520906808, 15585.454509092127, 15719.528414147593, 15798.21008949525, 15928.362865485715, 19655.70516442226, 19919.900400498485, 20004.59990800205, 20035.29876454317, 20096.19615215375], "value": 13166.11076093432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.1580925158783, 1465.8607432293934, 1479.5339468067564, 1495.297210311154, 1504.9924750376254, 17419.12904354782, 18075.90962045188, 18171.364002259925, 18176.636467270648, 18184.90873549542, 17557.736633950502, 17592.20835062422, 17663.5584110397, 17725.93644381335, 17763.0, 2918.4892643787357, 2992.730654241118, 2999.2052106191877, 3013.382256637384, 3030.8787648494035, 2967.8367689777056, 2992.012635830182, 3014.502607069831, 3021.4108248891366, 3022.531507616323, 2891.1326602019417, 2940.117964610619, 2948.631421072366, 2966.139819452367, 2981.344104297051, 2781.429806889603, 2791.902283420091, 2792.2181789099186, 2800.1599520143977, 2802.6917039125783, 2661.4144888124583, 2670.052131493311, 2694.743999320081, 2697.5953606959115, 2699.082312013925, 16336.0, 16631.334746610122, 16796.2441690123, 16807.66384672312, 16829.915850420668, 8335.583220838995, 8642.65429382824, 8686.739397818075, 8697.826043479095, 8701.30389568833, 5473.28847249855, 5660.60375773696, 5866.325372582122, 5894.557908156906, 5921.319048309457, 2141.4218161096574, 2153.7630860605323, 2198.736151661795, 2205.2943058221376, 2252.3017864462067, 27569.0, 29285.560716589054, 30696.2325941851, 30714.0, 30827.69172308293, 7746.49647772893, 7796.220377962159, 7811.765647030598, 7874.370050396069, 8219.794505137299, 24289.514209715708, 24445.755542444702, 24473.755262447503, 24563.63154552683, 24609.876950615133, 9051.683191088281, 9115.635374585076, 9123.726288211365, 9205.125513076247, 9208.907910920805, 7855.6464959076975, 7982.560959147303, 8160.4287699861625, 8213.260806527442, 8223.259906608433, 6264.498840092781, 6282.591631543935, 6333.493320534346, 6424.775132870327, 6507.121538592324, 1889.9433017009512, 1897.829195372423, 1898.3735367329025, 1906.5138389710535, 1912.4453908366695, 996.7607774134156, 1020.0870221152028, 1028.4086650176177, 1035.9223058270659, 1038.4911393417322, 8782.736517904474, 8853.601587928559, 8913.108689131164, 8953.820923581492, 9126.81746365069, 793.500094940184, 806.7700705298962, 811.6509900742619, 813.2883726739103, 818.5702506184182, 4952.281919121707, 5037.647364684511, 5047.419546752097, 5101.0818052750865, 5114.897702045938, 25304.0, 25839.354016149748, 26455.735442645713, 26767.732322676526, 26776.464470710478, 25738.87130564335, 25872.0, 26303.473930521282, 26378.0, 26410.207693769218, 11006.889931100746, 11292.153088518395, 12826.358682066046, 12830.486780528861, 12996.870031299566, 10232.48837558134, 10365.170786336925, 10442.530086146293, 10464.162866970471, 10641.8935810644, 21973.340799776033, 22168.445788854762, 22613.09547618077, 22778.772212277665, 23265.0, 23498.64752028755, 23577.882110589337, 23829.285121446384, 23984.40038999039, 24068.638970415108, 13355.332233388097, 13594.45622175102, 13597.79603305971, 13610.979176561996, 13613.659658508617, 15898.125603091941, 16010.439634612732, 16018.839811601734, 16194.595135121715, 16219.918900405422, 12791.36043197855, 12814.615561533168, 12833.935830320788, 12995.480180792661, 13360.131591446525, 12269.325187114437, 12307.446164922421, 12468.750624987631, 12503.56237531682, 12909.741805163656, 10987.890121098686, 11026.117910567296, 11038.944805275922, 11106.222564420414, 11127.499262533043, 8359.874601881098, 8393.202645748644, 8514.61684224199, 8563.229309361937, 8682.305415566865, 8551.10213427606, 8558.914410855812, 8572.614232359683, 8635.913640863762, 8639.04970453237], "value": 7565.321784446265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8479302984709, 575.8128608202335, 597.1848426897286, 610.5756499233032, 619.8264485943937, 6383.521235907308, 6455.612043410666, 6479.1901012373455, 6482.740690372391, 6485.351464853512, 6342.826577083243, 6392.55252132351, 6415.877221486245, 6448.742050317994, 6481.189851268591, 5281.155015197579, 5294.179402192666, 5310.867228319285, 5330.840074797762, 5344.759485823128, 4985.501449855004, 5257.23770053342, 5271.789128434858, 5282.550983166417, 5287.973560132214, 5123.974380128113, 5147.253648221005, 5159.587233021368, 5168.741562921858, 5192.428832828386, 5140.709945634778, 5155.845324640267, 5170.836561773608, 5179.0, 5197.4022987356375, 4675.462321832999, 4726.976365118187, 4733.408323959505, 4742.857714268577, 4751.097291514601, 6315.431611154972, 6356.745730170787, 6432.45324147448, 6432.646204458753, 6440.293322269602, 6055.122007308915, 6071.362506936796, 6099.9085013724825, 6105.328413874515, 6130.754769809202, 6788.639623386406, 6799.932000679979, 6812.659367031629, 6814.727410903558, 6855.143107111611, 5048.545630893201, 5217.50433708797, 5244.737763111867, 5259.684418934876, 5275.815346462894, 7003.54476958996, 7052.964735176342, 7100.928990710078, 7161.248068952789, 7168.354848063699, 5305.204219367049, 5332.733363331896, 5343.6526625769975, 5358.624896257303, 5376.768641014014, 5414.96938648007, 5444.673319600757, 5462.426445223274, 5477.398235837945, 5493.368262649767, 6044.607100538451, 6047.485963693048, 6073.726682299307, 6074.696265186812, 6098.505866062755, 6872.862542749217, 6875.48433867462, 6910.965445172843, 6948.270431604608, 6949.2008419031445, 1853.499555120137, 1854.9814501855078, 1869.3176990398679, 1876.6622008038685, 1877.4555378939954, 1300.7447812860635, 1338.5047532413068, 1349.311850956, 1351.8310211223597, 1357.395958798345, 6325.430711236011, 6470.255920569195, 6471.288158302583, 6472.870542589122, 6489.318621544764, 6815.250322464525, 6863.897041544381, 6921.792346229621, 6933.653317334113, 6983.3714965653335, 6457.354264573505, 6470.773522926675, 6478.416942475105, 6480.0, 6563.835904102436, 3659.835307411173, 3694.5751238607368, 3725.5529336479794, 3731.253749250161, 3733.5519737631657, 7214.799486156668, 7270.672819723125, 7298.817529561803, 7318.926810731825, 7419.2548756959195, 7005.754798582026, 7010.614416207056, 7135.250798666066, 7150.821229469201, 7249.4051308712, 7266.418686505172, 7301.561906285639, 7338.192798792129, 7342.706291748377, 7369.6315184240575, 6910.930890691029, 6988.231294557493, 6997.755078572225, 7011.404030657452, 7013.4038606719005, 6932.341427564374, 6954.79135625932, 6960.756373527105, 6963.860722785617, 7025.718971241093, 7275.290306778009, 7339.816504587215, 7348.70605175787, 7354.926450735638, 7367.8158046049275, 5306.867328316668, 5311.707856067954, 5313.707746074003, 5343.332083489564, 5358.115910874818, 6873.728360253369, 7017.7192912282935, 7041.295870413122, 7113.715451381887, 7142.428605711634, 6617.569857959217, 6687.799366019027, 6752.763653272112, 6796.320367963164, 6816.386525212754, 6629.0, 6700.631465269457, 6709.563878348087, 6714.0, 6714.194296684429, 6534.183227096613, 6642.169728783902, 6672.666366681549, 6704.899426508508, 6706.66466676674, 6786.3892249697765, 6835.14560679915, 6838.863222735617, 6880.759173428906, 6893.448524117958, 6567.9014814776865, 6592.76925307612, 6676.9332306676315, 6685.264620891795, 6741.460683145238], "value": 5372.2138847029755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.170255283009, 987.9110880020799, 1016.3292227130096, 1018.2007124407342, 1026.7535791410062, 19080.71378929317, 19137.42587722367, 21533.0, 21779.23772667957, 21840.781592184074, 19855.0, 19966.800331996677, 19987.100580473878, 20079.899600501976, 20100.396988090342, 999.3510707332922, 1022.5551884930079, 1029.4132344563602, 1030.289100520642, 1030.5929157982591, 1042.5152304178555, 1044.3316277582353, 1047.8480620310052, 1048.7692707604353, 1049.3861091261622, 1101.6639924822925, 1124.550179928027, 1132.1678566253797, 1132.184826924617, 1132.8244122161036, 1112.4271000434783, 1122.7529943412437, 1124.3984468309457, 1124.9325040497515, 1124.9381284029375, 816.8693009118513, 816.8938038055074, 817.5912043978011, 818.7339114787658, 823.5882058970515, 21242.83164425956, 21940.780592194034, 22411.887940560355, 22458.55082898349, 22507.662385064235, 20631.277905273244, 21028.0, 21037.68443473349, 21045.0, 21255.78744212569, 18879.244830206775, 19278.036098195033, 19361.322353717693, 19400.126994285292, 19429.125689343873, 3978.1446988897237, 4108.979455102735, 4118.546959834446, 4176.352665336878, 4180.895477613054, 132026.0, 145280.0, 164346.17826910788, 174275.0, 175586.1220693901, 18485.44543663692, 18758.0, 19008.714869276973, 19047.1428785705, 19047.42857714271, 34925.0, 35029.64970350264, 35083.824580876935, 35211.0, 35481.93554193378, 10028.69913902584, 10097.44464054484, 10110.24173187014, 10119.342242754197, 10133.442660653734, 4706.411698537683, 4738.431388233365, 4769.713817170981, 4788.377510923558, 4791.760411979387, 6526.869462610816, 6581.078648989145, 6646.83382915431, 6672.633005184664, 6681.665916704145, 1125.763589646167, 1147.20269412759, 1163.6334554615269, 1178.3342411537453, 1180.1738782852037, 728.9052423185058, 755.3466251692247, 760.2549501488462, 769.7883082152453, 772.9265719756614, 12832.80750788739, 13046.608601741962, 13134.211947283193, 13589.592312230649, 13788.241646709326, 755.6599530211317, 757.9242075792376, 764.3541207679502, 780.5862892666782, 784.4861615641764, 6383.265924418752, 6452.0, 6460.063290822898, 6592.571482853599, 6598.60408375499, 154708.0, 156896.0, 158172.0, 158710.0, 166007.0, 139395.0, 139534.0, 139955.0, 141824.0, 145973.27013364865, 120802.39598802125, 122270.0, 122324.0, 122375.0, 125260.37369813092, 12222.388880556115, 12346.444410001392, 12459.314737689514, 12517.311547864954, 12631.87368126307, 59723.0, 60145.0, 60192.0, 60908.086378705244, 61572.076418852856, 75315.62342188254, 76152.61923690345, 77110.0, 78030.60984695268, 79048.60475697585, 18008.819911800714, 18238.635227295646, 18391.90804045971, 18450.35423760162, 18535.72196417028, 20167.092480838102, 20343.389698309074, 20413.48966275855, 20424.285150019678, 20565.794342056386, 18325.99207043572, 18344.174512146717, 18480.722789157906, 18501.53746156357, 18586.442406727278, 18298.817011829713, 18514.814851851308, 18578.25686972506, 18620.0, 18622.441326760218, 15490.767638485206, 15493.07041577509, 15578.532644020697, 15647.061176329456, 15756.448524302054, 12342.197757145757, 12625.149329454605, 12682.619521414372, 12725.427355768827, 12727.872721272668, 13581.660458488617, 13814.65463363424, 13834.723305534035, 13858.307084645527, 13889.652758681113], "value": 10170.018277619276, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1355.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 105.0, 104.0, 105.0, 106.0, 106.0, 105.0, 105.0, 106.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 116.0, 111.0, 113.0, 111.0, 109.0, 111.0, 112.0, 141.0], "value": 114.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 74.0, 73.0, 72.0, 73.0, 73.0, 76.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 77.0, 77.0, 76.0, 77.0, 77.0, 87.0, 77.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 114.0, 110.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 154.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 43.0, 43.0, 43.0, 43.0, 44.0, 45.0, 43.0, 43.0, 42.0], "value": 43.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 37.0, 39.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 70.0, 68.0, 70.0, 69.0, 77.0, 71.0, 75.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 107.0, 100.0, 102.0, 109.0, 102.0, 110.0, 110.0, 103.0], "value": 105.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 148.0, 147.0, 158.0, 151.0, 144.0, 150.0, 150.0, 153.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 59.0, 63.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}]}]} 14:41:49 INFO - Return code: 0 14:41:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:41:49 INFO - # TBPL SUCCESS # 14:41:49 INFO - Running post-action listener: _package_coverage_data 14:41:49 INFO - Running post-action listener: _resource_record_post_action 14:41:49 INFO - [mozharness: 2017-10-12 21:41:49.957960Z] Finished run-tests step (success) 14:41:49 INFO - Running post-run listener: _resource_record_post_run 14:41:50 INFO - Total resource usage - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288174080; Read time: 16; Write time: 157136 14:41:50 INFO - TinderboxPrint: CPU usage
13.0% 14:41:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:41:50 INFO - TinderboxPrint: I/O write bytes / time
288,174,080 / 157,136 14:41:50 INFO - TinderboxPrint: CPU idle
8,167.2 (87.0%) 14:41:50 INFO - TinderboxPrint: CPU user
1,178.6 (12.5%) 14:41:50 INFO - TinderboxPrint: Swap in / out
0 / 0 14:41:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9113600; Read time: 0; Write time: 1308 14:41:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:41:50 INFO - run-tests - Wall time: 1164s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279060480; Read time: 16; Write time: 155828 14:41:50 INFO - Running post-run listener: _upload_blobber_files 14:41:50 INFO - Blob upload gear active. 14:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:41:50 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 14:41:50 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:41:50 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:41:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:51 INFO - (blobuploader) - INFO - Done attempting. 14:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:59 INFO - (blobuploader) - INFO - Done attempting. 14:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:00 INFO - (blobuploader) - INFO - Done attempting. 14:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:01 INFO - (blobuploader) - INFO - Done attempting. 14:42:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:01 INFO - Return code: 0 14:42:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e735e9f99f5334d94c0c971e54906575741d82ce9e03e6cd1608b37d8e23d8f6a4ccf89c48dca449d8f4dbd56e7d4d9bfb55324ff5f53f996e8078f87cca84f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73d6749c0503cb51bbaf7898c9a0d848a78b72194f46f4839c0f1a91e994d40673fbb8e03fc012b4ce0b85c7b56004c45e7501541ad2e9e88c398464ed0a35b9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b638d22549941b0515e53598a868b297b99e3cd1316d21b84f49e6a45d18eb9366df0e5b4f24b9a37651b633444840a57b86105d1208f8614510f2ac42fd3b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3d86ccc19abae796c6fd8ef26fc389f3471b7f7fec00b129f13bb1a627bfddbb17a457d90679e832fba3e283a6ebee11f5dbde3053ee161a0e50a6719998bc89"} 14:42:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:01 INFO - Contents: 14:42:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e735e9f99f5334d94c0c971e54906575741d82ce9e03e6cd1608b37d8e23d8f6a4ccf89c48dca449d8f4dbd56e7d4d9bfb55324ff5f53f996e8078f87cca84f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73d6749c0503cb51bbaf7898c9a0d848a78b72194f46f4839c0f1a91e994d40673fbb8e03fc012b4ce0b85c7b56004c45e7501541ad2e9e88c398464ed0a35b9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b638d22549941b0515e53598a868b297b99e3cd1316d21b84f49e6a45d18eb9366df0e5b4f24b9a37651b633444840a57b86105d1208f8614510f2ac42fd3b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3d86ccc19abae796c6fd8ef26fc389f3471b7f7fec00b129f13bb1a627bfddbb17a457d90679e832fba3e283a6ebee11f5dbde3053ee161a0e50a6719998bc89"} 14:42:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:01 INFO - Copying logs to upload dir... 14:42:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.132352 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-12 14:42:01.758130) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 14:42:01.764810) ========= 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=923d835db2ba3686ebe126b700000192-1507837275.569208-155156370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e735e9f99f5334d94c0c971e54906575741d82ce9e03e6cd1608b37d8e23d8f6a4ccf89c48dca449d8f4dbd56e7d4d9bfb55324ff5f53f996e8078f87cca84f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73d6749c0503cb51bbaf7898c9a0d848a78b72194f46f4839c0f1a91e994d40673fbb8e03fc012b4ce0b85c7b56004c45e7501541ad2e9e88c398464ed0a35b9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b638d22549941b0515e53598a868b297b99e3cd1316d21b84f49e6a45d18eb9366df0e5b4f24b9a37651b633444840a57b86105d1208f8614510f2ac42fd3b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3d86ccc19abae796c6fd8ef26fc389f3471b7f7fec00b129f13bb1a627bfddbb17a457d90679e832fba3e283a6ebee11f5dbde3053ee161a0e50a6719998bc89"} build_url:https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/BRfAEVDuTBye6F92yPuPVQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1e735e9f99f5334d94c0c971e54906575741d82ce9e03e6cd1608b37d8e23d8f6a4ccf89c48dca449d8f4dbd56e7d4d9bfb55324ff5f53f996e8078f87cca84f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73d6749c0503cb51bbaf7898c9a0d848a78b72194f46f4839c0f1a91e994d40673fbb8e03fc012b4ce0b85c7b56004c45e7501541ad2e9e88c398464ed0a35b9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b638d22549941b0515e53598a868b297b99e3cd1316d21b84f49e6a45d18eb9366df0e5b4f24b9a37651b633444840a57b86105d1208f8614510f2ac42fd3b7", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3d86ccc19abae796c6fd8ef26fc389f3471b7f7fec00b129f13bb1a627bfddbb17a457d90679e832fba3e283a6ebee11f5dbde3053ee161a0e50a6719998bc89"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-12 14:42:01.795428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:42:01.795811) ========= 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=923d835db2ba3686ebe126b700000192-1507837275.569208-155156370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-12 14:42:01.878353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 14:42:01.878672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-12 14:42:01.879002) ========= ========= Total master_lag: 0.20 =========